builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-048 starttime: 1476883363.77 results: success (0) buildid: 20161019033001 builduid: ffb753fb78844eddabf486158819cd06 revision: e4282badddda00fb555bd2e5300c92149434a884 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-19 06:22:43.770442) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-19 06:22:43.770961) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-19 06:22:43.771243) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-19 06:22:43.802515) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-19 06:22:43.802866) ========= 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=fa44defc139c4ba8574fe040000001db-1476881895.368588-165433251 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-19 06:22:44-- 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% 36.9M=0s 2016-10-19 06:22:44 (36.9 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.094249 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-19 06:22:43.910603) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-19 06:22:43.910919) ========= 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=fa44defc139c4ba8574fe040000001db-1476881895.368588-165433251 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014363 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-19 06:22:43.960275) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-19 06:22:43.960614) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev e4282badddda00fb555bd2e5300c92149434a884 --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 e4282badddda00fb555bd2e5300c92149434a884 --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=fa44defc139c4ba8574fe040000001db-1476881895.368588-165433251 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-19 06:22:44,651 truncating revision to first 12 chars 2016-10-19 06:22:44,651 Setting DEBUG logging. 2016-10-19 06:22:44,651 attempt 1/10 2016-10-19 06:22:44,651 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/e4282badddda?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-19 06:22:44,978 unpacking tar archive at: fx-team-e4282badddda/testing/mozharness/ program finished with exit code 0 elapsedTime=0.651924 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-19 06:22:44.625512) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-19 06:22:44.625824) ========= script_repo_revision: e4282badddda00fb555bd2e5300c92149434a884 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-19 06:22:44.626225) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-19 06:22:44.626840) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-19 06:22:44.637749) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-10-19 06:22:44.638081) ========= /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=fa44defc139c4ba8574fe040000001db-1476881895.368588-165433251 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:22:45 INFO - MultiFileLogger online at 20161019 06:22:45 in /builds/slave/test 06:22:45 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:22:45 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:22:45 INFO - {'append_to_log': False, 06:22:45 INFO - 'base_work_dir': '/builds/slave/test', 06:22:45 INFO - 'blob_upload_branch': 'Fx-Team', 06:22:45 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:22:45 INFO - 'branch': 'Fx-Team', 06:22:45 INFO - 'buildbot_json_path': 'buildprops.json', 06:22:45 INFO - 'config_files': ('talos/linux_config.py',), 06:22:45 INFO - 'default_actions': ('clobber', 06:22:45 INFO - 'read-buildbot-config', 06:22:45 INFO - 'download-and-extract', 06:22:45 INFO - 'populate-webroot', 06:22:45 INFO - 'create-virtualenv', 06:22:45 INFO - 'install', 06:22:45 INFO - 'run-tests'), 06:22:45 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:22:45 INFO - 'download_minidump_stackwalk': True, 06:22:45 INFO - 'download_symbols': 'ondemand', 06:22:45 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:22:45 INFO - 'tooltool.py': '/tools/tooltool.py', 06:22:45 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:22:45 INFO - '/tools/misc-python/virtualenv.py')}, 06:22:45 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:22:45 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:22:45 INFO - 'installer_path': 'installer.exe', 06:22:45 INFO - 'log_level': 'info', 06:22:45 INFO - 'log_name': 'talos', 06:22:45 INFO - 'log_to_console': True, 06:22:45 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:22:45 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:22:45 INFO - 'opt_config_files': (), 06:22:45 INFO - 'pip_index': False, 06:22:45 INFO - 'sps_profile': False, 06:22:45 INFO - 'sps_profile_interval': 0, 06:22:45 INFO - 'suite': 'dromaeojs', 06:22:45 INFO - 'system_bits': '32', 06:22:45 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:22:45 INFO - 'title': 'talos-linux64-ix-048', 06:22:45 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:22:45 INFO - 'use_talos_json': True, 06:22:45 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:22:45 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:22:45 INFO - 'work_dir': 'build'} 06:22:45 INFO - [mozharness: 2016-10-19 13:22:45.420447Z] Running clobber step. 06:22:45 INFO - Running pre-action listener: _resource_record_pre_action 06:22:45 INFO - Running main action method: clobber 06:22:45 INFO - rmtree: /builds/slave/test/build 06:22:45 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:22:45 INFO - Running post-action listener: _resource_record_post_action 06:22:45 INFO - [mozharness: 2016-10-19 13:22:45.886071Z] Finished clobber step (success) 06:22:45 INFO - [mozharness: 2016-10-19 13:22:45.886174Z] Running read-buildbot-config step. 06:22:45 INFO - Running pre-action listener: _resource_record_pre_action 06:22:45 INFO - Running main action method: read_buildbot_config 06:22:45 INFO - Using buildbot properties: 06:22:45 INFO - { 06:22:45 INFO - "project": "", 06:22:45 INFO - "product": "firefox", 06:22:45 INFO - "script_repo_revision": "production", 06:22:45 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 06:22:45 INFO - "repository": "", 06:22:45 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 06:22:45 INFO - "buildid": "20161019033001", 06:22:45 INFO - "pgo_build": "True", 06:22:45 INFO - "basedir": "/builds/slave/test", 06:22:45 INFO - "buildnumber": 1643, 06:22:45 INFO - "slavename": "talos-linux64-ix-048", 06:22:45 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 06:22:45 INFO - "platform": "ubuntu64_hw", 06:22:45 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 06:22:45 INFO - "branch": "fx-team", 06:22:45 INFO - "repo_path": "integration/fx-team", 06:22:45 INFO - "revision": "e4282badddda00fb555bd2e5300c92149434a884", 06:22:45 INFO - "stage_platform": "linux64-pgo", 06:22:45 INFO - "builduid": "ffb753fb78844eddabf486158819cd06", 06:22:45 INFO - "slavebuilddir": "test" 06:22:45 INFO - } 06:22:45 INFO - Found installer url https://queue.taskcluster.net/v1/task/cNTRzk_8ST6jwfySUbuL_Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 06:22:45 INFO - Running post-action listener: _resource_record_post_action 06:22:45 INFO - [mozharness: 2016-10-19 13:22:45.888657Z] Finished read-buildbot-config step (success) 06:22:45 INFO - [mozharness: 2016-10-19 13:22:45.888747Z] Running download-and-extract step. 06:22:45 INFO - Running pre-action listener: _resource_record_pre_action 06:22:45 INFO - Running main action method: download_and_extract 06:22:45 INFO - mkdir: /builds/slave/test/build/tests 06:22:45 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:22:45 INFO - trying https://queue.taskcluster.net/v1/task/cNTRzk_8ST6jwfySUbuL_Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 06:22:45 INFO - Downloading https://queue.taskcluster.net/v1/task/cNTRzk_8ST6jwfySUbuL_Q/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:22:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cNTRzk_8ST6jwfySUbuL_Q/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:22:46 INFO - Downloaded 1361 bytes. 06:22:46 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 06:22:46 INFO - Using the following test package requirements: 06:22:46 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 06:22:46 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:22:46 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 06:22:46 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:22:46 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 06:22:46 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:22:46 INFO - u'jsshell-linux-x86_64.zip'], 06:22:46 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:22:46 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 06:22:46 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 06:22:46 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:22:46 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 06:22:46 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:22:46 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 06:22:46 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:22:46 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 06:22:46 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:22:46 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 06:22:46 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:22:46 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/cNTRzk_8ST6jwfySUbuL_Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 06:22:46 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/cNTRzk_8ST6jwfySUbuL_Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:22:46 INFO - Fetch https://queue.taskcluster.net/v1/task/cNTRzk_8ST6jwfySUbuL_Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 06:22:47 INFO - Http code: 200 06:22:47 INFO - via: 1.1 4c2196e36fd33f377384d605b4424e95.cloudfront.net (CloudFront) 06:22:47 INFO - x-amz-cf-id: DgL_grVFbePV_YJRZ0pQsoY4id9BHp8uFQjxzV-uJWEXdBXTSeTbKw== 06:22:47 INFO - x-amz-version-id: 0GUaShf1TgWZD._uA.q_HUg8PCl5e00K 06:22:48 INFO - Expected file size: 22111204 06:22:48 INFO - Obtained file size: 22111204 06:22: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:22:52 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/cNTRzk_8ST6jwfySUbuL_Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 06:22:52 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/cNTRzk_8ST6jwfySUbuL_Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:22:52 INFO - Fetch https://queue.taskcluster.net/v1/task/cNTRzk_8ST6jwfySUbuL_Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 06:22:53 INFO - Http code: 200 06:22:53 INFO - via: 1.1 e1eb7447ab46f530f6009f1d93917c54.cloudfront.net (CloudFront) 06:22:53 INFO - x-amz-cf-id: d5KetVQEw_oe1uJR8el3JddSD6g8wLA1d5ffNl-5ObGBCZPS48kBOg== 06:22:53 INFO - x-amz-version-id: 0GUaShf1TgWZD._uA.q_HUg8PCl5e00K 06:22:53 INFO - Expected file size: 22111204 06:22:53 INFO - Obtained file size: 22111204 06:22:57 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/cNTRzk_8ST6jwfySUbuL_Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 06:22:57 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/cNTRzk_8ST6jwfySUbuL_Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 06:22:57 INFO - Fetch https://queue.taskcluster.net/v1/task/cNTRzk_8ST6jwfySUbuL_Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 06:22:58 INFO - Http code: 200 06:22:58 INFO - via: 1.1 d8f42fc9558e3e49ebfdf8834baeb756.cloudfront.net (CloudFront) 06:22:58 INFO - x-amz-cf-id: wIGY4_WdPqyDRFmgxQCv9MfmbEwBJvuXOz-IroU7Z6GvTH4XNOaB0A== 06:22:58 INFO - x-amz-version-id: y93vM4HTehC3Uo_HLYjEq2uSytqDwFzI 06:22:59 INFO - Expected file size: 14409028 06:22:59 INFO - Obtained file size: 14409028 06:22: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:22:59 INFO - trying https://queue.taskcluster.net/v1/task/cNTRzk_8ST6jwfySUbuL_Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 06:22:59 INFO - Downloading https://queue.taskcluster.net/v1/task/cNTRzk_8ST6jwfySUbuL_Q/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:22:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cNTRzk_8ST6jwfySUbuL_Q/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:23:01 INFO - Downloaded 59475307 bytes. 06:23:01 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/cNTRzk_8ST6jwfySUbuL_Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 06:23:01 INFO - mkdir: /builds/slave/test/properties 06:23:01 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:23:01 INFO - Writing to file /builds/slave/test/properties/build_url 06:23:01 INFO - Contents: 06:23:01 INFO - build_url:https://queue.taskcluster.net/v1/task/cNTRzk_8ST6jwfySUbuL_Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 06:23:02 INFO - Running post-action listener: _resource_record_post_action 06:23:02 INFO - Running post-action listener: set_extra_try_arguments 06:23:02 INFO - [mozharness: 2016-10-19 13:23:02.294497Z] Finished download-and-extract step (success) 06:23:02 INFO - [mozharness: 2016-10-19 13:23:02.294726Z] Running populate-webroot step. 06:23:02 INFO - Running pre-action listener: _resource_record_pre_action 06:23:02 INFO - Running main action method: populate_webroot 06:23:02 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:23:02 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:23:02 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:23:02 INFO - '--tppagecycles', 06:23:02 INFO - '7'], 06:23:02 INFO - 'tests': ['tsvgm']}}, 06:23:02 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:23:02 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:23:02 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:23:02 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:23:02 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:23:02 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:23:02 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:23:02 INFO - 'talos_options': ['--disable-e10s'], 06:23:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:23:02 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:23:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:23:02 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:23:02 INFO - 'talos_options': ['--disable-e10s'], 06:23:02 INFO - 'tests': ['damp', 'tps']}, 06:23:02 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:23:02 INFO - 'tests': ['damp', 'tps']}, 06:23:02 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:23:02 INFO - 'tests': ['dromaeo_dom']}, 06:23:02 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:23:02 INFO - 'g4': {'talos_options': ['--disable-e10s'], 06:23:02 INFO - 'tests': ['basic_compositor_video']}, 06:23:02 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 06:23:02 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:23:02 INFO - 'tests': ['a11yr', 06:23:02 INFO - 'ts_paint', 06:23:02 INFO - 'tpaint', 06:23:02 INFO - 'sessionrestore', 06:23:02 INFO - 'sessionrestore_no_auto_restore', 06:23:02 INFO - 'tabpaint']}, 06:23:02 INFO - 'other-e10s': {'tests': ['a11yr', 06:23:02 INFO - 'ts_paint', 06:23:02 INFO - 'tpaint', 06:23:02 INFO - 'sessionrestore', 06:23:02 INFO - 'sessionrestore_no_auto_restore', 06:23:02 INFO - 'tabpaint']}, 06:23:02 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:23:02 INFO - 'ts_paint', 06:23:02 INFO - 'tpaint', 06:23:02 INFO - 'sessionrestore', 06:23:02 INFO - 'sessionrestore_no_auto_restore', 06:23:02 INFO - 'tabpaint']}, 06:23:02 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:23:02 INFO - 'ts_paint', 06:23:02 INFO - 'tpaint', 06:23:02 INFO - 'sessionrestore', 06:23:02 INFO - 'sessionrestore_no_auto_restore', 06:23:02 INFO - 'tabpaint']}, 06:23:02 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:23:02 INFO - 'tests': ['a11yr', 06:23:02 INFO - 'ts_paint', 06:23:02 INFO - 'tpaint', 06:23:02 INFO - 'sessionrestore', 06:23:02 INFO - 'sessionrestore_no_auto_restore', 06:23:02 INFO - 'tabpaint']}, 06:23:02 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:23:02 INFO - 'tests': ['a11yr', 06:23:02 INFO - 'ts_paint', 06:23:02 INFO - 'tpaint', 06:23:02 INFO - 'sessionrestore', 06:23:02 INFO - 'sessionrestore_no_auto_restore', 06:23:02 INFO - 'tabpaint']}, 06:23:02 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:23:02 INFO - 'tests': ['tsvgx', 06:23:02 INFO - 'tsvgr_opacity', 06:23:02 INFO - 'tart', 06:23:02 INFO - 'tscrollx', 06:23:02 INFO - 'cart']}, 06:23:02 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:23:02 INFO - 'tsvgr_opacity', 06:23:02 INFO - 'tart', 06:23:02 INFO - 'tscrollx', 06:23:02 INFO - 'cart']}, 06:23:02 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:23:02 INFO - 'talos_options': ['--disable-e10s'], 06:23:02 INFO - 'tests': ['tp5o']}, 06:23:02 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:23:02 INFO - 'tests': ['tp5o']}, 06:23:02 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:23:02 INFO - 'talos_options': ['--disable-e10s', 06:23:02 INFO - '--xperf_path', 06:23:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:23:02 INFO - 'tests': ['tp5n']}, 06:23:02 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:23:02 INFO - 'talos_options': ['--xperf_path', 06:23:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:23:02 INFO - 'tests': ['tp5n']}}, 06:23:02 INFO - 'talos.zip': {'path': '', 06:23:02 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:23:02 INFO - Running post-action listener: _resource_record_post_action 06:23:02 INFO - [mozharness: 2016-10-19 13:23:02.311750Z] Finished populate-webroot step (success) 06:23:02 INFO - [mozharness: 2016-10-19 13:23:02.311840Z] Running create-virtualenv step. 06:23:02 INFO - Running pre-action listener: _resource_record_pre_action 06:23:02 INFO - Running main action method: create_virtualenv 06:23:02 INFO - Creating virtualenv /builds/slave/test/build/venv 06:23: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:23:02 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:23:02 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:23:02 INFO - Using real prefix '/usr' 06:23:02 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:23:02 INFO - Installing distribute.............................................................................................................................................................................................done. 06:23:04 INFO - Installing pip.................done. 06:23:04 INFO - Return code: 0 06:23:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 06:23:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 06:23:05 INFO - Reading from file tmpfile_stdout 06:23:05 INFO - Output received: 06:23: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:23:05 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:23: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:23:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:23:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:23: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:23:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:23:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:23: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 0x7f0d817b9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e6a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f37790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f34930>, '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 0x1f35830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f35cc0>, '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': 'fa44defc139c4ba8574fe040000001db-1476881895.368588-165433251', '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:23: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:23: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:23:05 INFO - Using env: {'DISPLAY': ':0', 06:23:05 INFO - 'HOME': '/home/cltbld', 06:23:05 INFO - 'LANG': 'en_US.UTF-8', 06:23:05 INFO - 'LANGUAGE': 'en_US:en', 06:23:05 INFO - 'LOGNAME': 'cltbld', 06:23:05 INFO - 'MAIL': '/var/mail/cltbld', 06:23:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:23:05 INFO - 'MOZ_NO_REMOTE': '1', 06:23:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:23:05 INFO - 'NO_EM_RESTART': '1', 06:23:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:23:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:23:05 INFO - 'PWD': '/builds/slave/test', 06:23:05 INFO - 'SHELL': '/bin/bash', 06:23:05 INFO - 'SHLVL': '1', 06:23:05 INFO - 'TERM': 'linux', 06:23:05 INFO - 'TMOUT': '86400', 06:23:05 INFO - 'USER': 'cltbld', 06:23:05 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1476881895.368588-165433251', 06:23:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:23:05 INFO - '_': '/tools/buildbot/bin/python'} 06:23:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:23: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:23:05 INFO - Cleaning up... 06:23:05 INFO - Return code: 0 06:23:05 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:23: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:23:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:23:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:23: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:23:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:23:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:23: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 0x7f0d817b9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e6a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f37790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f34930>, '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 0x1f35830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f35cc0>, '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': 'fa44defc139c4ba8574fe040000001db-1476881895.368588-165433251', '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:23: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:23: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:23:05 INFO - Using env: {'DISPLAY': ':0', 06:23:05 INFO - 'HOME': '/home/cltbld', 06:23:05 INFO - 'LANG': 'en_US.UTF-8', 06:23:05 INFO - 'LANGUAGE': 'en_US:en', 06:23:05 INFO - 'LOGNAME': 'cltbld', 06:23:05 INFO - 'MAIL': '/var/mail/cltbld', 06:23:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:23:05 INFO - 'MOZ_NO_REMOTE': '1', 06:23:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:23:05 INFO - 'NO_EM_RESTART': '1', 06:23:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:23:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:23:05 INFO - 'PWD': '/builds/slave/test', 06:23:05 INFO - 'SHELL': '/bin/bash', 06:23:05 INFO - 'SHLVL': '1', 06:23:05 INFO - 'TERM': 'linux', 06:23:05 INFO - 'TMOUT': '86400', 06:23:05 INFO - 'USER': 'cltbld', 06:23:05 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1476881895.368588-165433251', 06:23:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:23:05 INFO - '_': '/tools/buildbot/bin/python'} 06:23:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:23:05 INFO - Downloading/unpacking psutil>=3.1.1 06:23: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:23: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:23: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:23: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:23: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:23: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:23:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:23:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:23:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:23:07 INFO - Installing collected packages: psutil 06:23:07 INFO - Running setup.py install for psutil 06:23:07 INFO - building 'psutil._psutil_linux' extension 06:23: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:23: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:23:07 INFO - building 'psutil._psutil_posix' extension 06:23: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:23: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:23:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:23:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:23:08 INFO - Successfully installed psutil 06:23:08 INFO - Cleaning up... 06:23:08 INFO - Return code: 0 06:23:08 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:23: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:23:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:23:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:23: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:23:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:23:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:23: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 0x7f0d817b9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e6a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f37790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f34930>, '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 0x1f35830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f35cc0>, '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': 'fa44defc139c4ba8574fe040000001db-1476881895.368588-165433251', '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:23: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:23: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:23:08 INFO - Using env: {'DISPLAY': ':0', 06:23:08 INFO - 'HOME': '/home/cltbld', 06:23:08 INFO - 'LANG': 'en_US.UTF-8', 06:23:08 INFO - 'LANGUAGE': 'en_US:en', 06:23:08 INFO - 'LOGNAME': 'cltbld', 06:23:08 INFO - 'MAIL': '/var/mail/cltbld', 06:23:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:23:08 INFO - 'MOZ_NO_REMOTE': '1', 06:23:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:23:08 INFO - 'NO_EM_RESTART': '1', 06:23:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:23:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:23:08 INFO - 'PWD': '/builds/slave/test', 06:23:08 INFO - 'SHELL': '/bin/bash', 06:23:08 INFO - 'SHLVL': '1', 06:23:08 INFO - 'TERM': 'linux', 06:23:08 INFO - 'TMOUT': '86400', 06:23:08 INFO - 'USER': 'cltbld', 06:23:08 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1476881895.368588-165433251', 06:23:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:23:08 INFO - '_': '/tools/buildbot/bin/python'} 06:23:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:23:08 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:23: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:23: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:23: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:23: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:23: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:23: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:23:10 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:23:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:23: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:23:10 INFO - Installing collected packages: mozsystemmonitor 06:23:10 INFO - Running setup.py install for mozsystemmonitor 06:23:10 INFO - Successfully installed mozsystemmonitor 06:23:10 INFO - Cleaning up... 06:23:10 INFO - Return code: 0 06:23:10 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:23: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:23:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:23:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:23: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:23:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:23:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:23: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 0x7f0d817b9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e6a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f37790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f34930>, '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 0x1f35830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f35cc0>, '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': 'fa44defc139c4ba8574fe040000001db-1476881895.368588-165433251', '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:23: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:23: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:23:10 INFO - Using env: {'DISPLAY': ':0', 06:23:10 INFO - 'HOME': '/home/cltbld', 06:23:10 INFO - 'LANG': 'en_US.UTF-8', 06:23:10 INFO - 'LANGUAGE': 'en_US:en', 06:23:10 INFO - 'LOGNAME': 'cltbld', 06:23:10 INFO - 'MAIL': '/var/mail/cltbld', 06:23:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:23:10 INFO - 'MOZ_NO_REMOTE': '1', 06:23:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:23:10 INFO - 'NO_EM_RESTART': '1', 06:23:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:23:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:23:10 INFO - 'PWD': '/builds/slave/test', 06:23:10 INFO - 'SHELL': '/bin/bash', 06:23:10 INFO - 'SHLVL': '1', 06:23:10 INFO - 'TERM': 'linux', 06:23:10 INFO - 'TMOUT': '86400', 06:23:10 INFO - 'USER': 'cltbld', 06:23:10 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1476881895.368588-165433251', 06:23:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:23:10 INFO - '_': '/tools/buildbot/bin/python'} 06:23:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:23:10 INFO - Downloading/unpacking jsonschema==2.5.1 06:23: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:23: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:23: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:23: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:23: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:23: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:23:12 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:23:12 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:23: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:23: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:23: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:23: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:23: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:23: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:23:12 INFO - Downloading functools32-3.2.3-2.tar.gz 06:23:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:23:12 INFO - warning: no files found matching '*.txt' 06:23:12 INFO - no previously-included directories found matching 'build' 06:23:12 INFO - no previously-included directories found matching 'dist' 06:23:12 INFO - no previously-included directories found matching '.git*' 06:23:12 INFO - Installing collected packages: jsonschema, functools32 06:23:12 INFO - Running setup.py install for functools32 06:23:13 INFO - warning: no files found matching '*.txt' 06:23:13 INFO - no previously-included directories found matching 'build' 06:23:13 INFO - no previously-included directories found matching 'dist' 06:23:13 INFO - no previously-included directories found matching '.git*' 06:23:13 INFO - Successfully installed jsonschema functools32 06:23:13 INFO - Cleaning up... 06:23:13 INFO - Return code: 0 06:23:13 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 06:23: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:23:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:23:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:23: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:23:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:23:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:23: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 0x7f0d817b9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e6a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f37790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f34930>, '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 0x1f35830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f35cc0>, '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': 'fa44defc139c4ba8574fe040000001db-1476881895.368588-165433251', '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:23: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:23: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:23:13 INFO - Using env: {'DISPLAY': ':0', 06:23:13 INFO - 'HOME': '/home/cltbld', 06:23:13 INFO - 'LANG': 'en_US.UTF-8', 06:23:13 INFO - 'LANGUAGE': 'en_US:en', 06:23:13 INFO - 'LOGNAME': 'cltbld', 06:23:13 INFO - 'MAIL': '/var/mail/cltbld', 06:23:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:23:13 INFO - 'MOZ_NO_REMOTE': '1', 06:23:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:23:13 INFO - 'NO_EM_RESTART': '1', 06:23:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:23:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:23:13 INFO - 'PWD': '/builds/slave/test', 06:23:13 INFO - 'SHELL': '/bin/bash', 06:23:13 INFO - 'SHLVL': '1', 06:23:13 INFO - 'TERM': 'linux', 06:23:13 INFO - 'TMOUT': '86400', 06:23:13 INFO - 'USER': 'cltbld', 06:23:13 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1476881895.368588-165433251', 06:23:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:23:13 INFO - '_': '/tools/buildbot/bin/python'} 06:23:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:23:13 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 06:23:13 INFO - Cleaning up... 06:23:13 INFO - Return code: 0 06:23:13 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:23: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:23:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:23:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:23: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:23:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:23:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:23: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 0x7f0d817b9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e6a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f37790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f34930>, '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 0x1f35830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f35cc0>, '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': 'fa44defc139c4ba8574fe040000001db-1476881895.368588-165433251', '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:23: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:23: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:23:13 INFO - Using env: {'DISPLAY': ':0', 06:23:13 INFO - 'HOME': '/home/cltbld', 06:23:13 INFO - 'LANG': 'en_US.UTF-8', 06:23:13 INFO - 'LANGUAGE': 'en_US:en', 06:23:13 INFO - 'LOGNAME': 'cltbld', 06:23:13 INFO - 'MAIL': '/var/mail/cltbld', 06:23:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:23:13 INFO - 'MOZ_NO_REMOTE': '1', 06:23:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:23:13 INFO - 'NO_EM_RESTART': '1', 06:23:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:23:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:23:13 INFO - 'PWD': '/builds/slave/test', 06:23:13 INFO - 'SHELL': '/bin/bash', 06:23:13 INFO - 'SHLVL': '1', 06:23:13 INFO - 'TERM': 'linux', 06:23:13 INFO - 'TMOUT': '86400', 06:23:13 INFO - 'USER': 'cltbld', 06:23:13 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1476881895.368588-165433251', 06:23:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:23:13 INFO - '_': '/tools/buildbot/bin/python'} 06:23:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:23:13 INFO - Downloading/unpacking blobuploader==1.2.4 06:23: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:23: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:23: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:23: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:23: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:23: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:23:15 INFO - Downloading blobuploader-1.2.4.tar.gz 06:23:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:23:15 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:23: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:23: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:23: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:23: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:23: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:23: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:23:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:23:16 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:23: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:23: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:23: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:23: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:23: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:23: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:23:16 INFO - Downloading docopt-0.6.1.tar.gz 06:23:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:23:16 INFO - Installing collected packages: blobuploader, requests, docopt 06:23:16 INFO - Running setup.py install for blobuploader 06:23:16 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:23:16 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:23:16 INFO - Running setup.py install for requests 06:23:16 INFO - Running setup.py install for docopt 06:23:16 INFO - Successfully installed blobuploader requests docopt 06:23:16 INFO - Cleaning up... 06:23:16 INFO - Return code: 0 06:23:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:23: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:23:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:23:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:23: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:23:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:23:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:23:16 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 0x7f0d817b9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e6a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f37790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f34930>, '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 0x1f35830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f35cc0>, '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': 'fa44defc139c4ba8574fe040000001db-1476881895.368588-165433251', '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:23:16 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:23:16 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:23:16 INFO - Using env: {'DISPLAY': ':0', 06:23:16 INFO - 'HOME': '/home/cltbld', 06:23:16 INFO - 'LANG': 'en_US.UTF-8', 06:23:16 INFO - 'LANGUAGE': 'en_US:en', 06:23:16 INFO - 'LOGNAME': 'cltbld', 06:23:16 INFO - 'MAIL': '/var/mail/cltbld', 06:23:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:23:16 INFO - 'MOZ_NO_REMOTE': '1', 06:23:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:23:16 INFO - 'NO_EM_RESTART': '1', 06:23:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:23:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:23:16 INFO - 'PWD': '/builds/slave/test', 06:23:16 INFO - 'SHELL': '/bin/bash', 06:23:16 INFO - 'SHLVL': '1', 06:23:16 INFO - 'TERM': 'linux', 06:23:16 INFO - 'TMOUT': '86400', 06:23:16 INFO - 'USER': 'cltbld', 06:23:16 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1476881895.368588-165433251', 06:23:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:23:16 INFO - '_': '/tools/buildbot/bin/python'} 06:23:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:23:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:23:17 INFO - Running setup.py (path:/tmp/pip-0qmAgt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:23:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:23:17 INFO - Running setup.py (path:/tmp/pip-L58uqE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:23:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:23:17 INFO - Running setup.py (path:/tmp/pip-qHJe9p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:23:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:23:17 INFO - Running setup.py (path:/tmp/pip-ihqkvI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:23:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:23:17 INFO - Running setup.py (path:/tmp/pip-ztPfJT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:23:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:23:17 INFO - Running setup.py (path:/tmp/pip-lSWQmd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:23:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:23:17 INFO - Running setup.py (path:/tmp/pip-OlQidG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:23:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:23:17 INFO - Running setup.py (path:/tmp/pip-rBoEKU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:23:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:23:17 INFO - Running setup.py (path:/tmp/pip-yM7qfx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:23:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:23:17 INFO - Running setup.py (path:/tmp/pip-nPOrFd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:23:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:23:17 INFO - Running setup.py (path:/tmp/pip-oY0gvE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:23:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:23:17 INFO - Running setup.py (path:/tmp/pip-LMmoU8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:23:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:23:18 INFO - Running setup.py (path:/tmp/pip-bogl_D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:23:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:23:18 INFO - Running setup.py (path:/tmp/pip-OMsHU8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:23:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:23:18 INFO - Running setup.py (path:/tmp/pip-3GAoUi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:23:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:23:18 INFO - Running setup.py (path:/tmp/pip-YB03Xs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:23:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:23:18 INFO - Running setup.py (path:/tmp/pip-16HZJL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:23:18 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:23:18 INFO - Running setup.py install for manifestparser 06:23:18 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:23:18 INFO - Running setup.py install for mozcrash 06:23:18 INFO - Running setup.py install for mozdebug 06:23:18 INFO - Running setup.py install for mozdevice 06:23:18 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:23:18 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:23:18 INFO - Running setup.py install for mozfile 06:23:18 INFO - Running setup.py install for mozhttpd 06:23:18 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:23:18 INFO - Running setup.py install for mozinfo 06:23:19 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:23:19 INFO - Running setup.py install for mozInstall 06:23:19 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:23:19 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:23:19 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:23:19 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:23:19 INFO - Running setup.py install for mozleak 06:23:19 INFO - Running setup.py install for mozlog 06:23:19 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:23:19 INFO - Running setup.py install for moznetwork 06:23:19 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:23:19 INFO - Running setup.py install for mozprocess 06:23:19 INFO - Running setup.py install for mozprofile 06:23:19 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:23:19 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:23:19 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:23:19 INFO - Running setup.py install for mozrunner 06:23:19 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:23:19 INFO - Running setup.py install for mozscreenshot 06:23:19 INFO - Running setup.py install for moztest 06:23:20 INFO - Running setup.py install for mozversion 06:23:20 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:23:20 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:23:20 INFO - Cleaning up... 06:23:20 INFO - Return code: 0 06:23:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:23: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:23:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:23:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:23: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:23:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:23:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:23: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 0x7f0d817b9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e6a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f37790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f34930>, '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 0x1f35830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f35cc0>, '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': 'fa44defc139c4ba8574fe040000001db-1476881895.368588-165433251', '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:23: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:23: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:23:20 INFO - Using env: {'DISPLAY': ':0', 06:23:20 INFO - 'HOME': '/home/cltbld', 06:23:20 INFO - 'LANG': 'en_US.UTF-8', 06:23:20 INFO - 'LANGUAGE': 'en_US:en', 06:23:20 INFO - 'LOGNAME': 'cltbld', 06:23:20 INFO - 'MAIL': '/var/mail/cltbld', 06:23:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:23:20 INFO - 'MOZ_NO_REMOTE': '1', 06:23:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:23:20 INFO - 'NO_EM_RESTART': '1', 06:23:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:23:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:23:20 INFO - 'PWD': '/builds/slave/test', 06:23:20 INFO - 'SHELL': '/bin/bash', 06:23:20 INFO - 'SHLVL': '1', 06:23:20 INFO - 'TERM': 'linux', 06:23:20 INFO - 'TMOUT': '86400', 06:23:20 INFO - 'USER': 'cltbld', 06:23:20 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1476881895.368588-165433251', 06:23:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:23:20 INFO - '_': '/tools/buildbot/bin/python'} 06:23:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:23:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:23:20 INFO - Running setup.py (path:/tmp/pip-H9A5Hb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:23: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:23:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:23:20 INFO - Running setup.py (path:/tmp/pip-CPVeDf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:23: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:23:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:23:20 INFO - Running setup.py (path:/tmp/pip-ByJFVT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:23: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:23:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:23:20 INFO - Running setup.py (path:/tmp/pip-s41AJa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:23: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:23:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:23:20 INFO - Running setup.py (path:/tmp/pip-p5mvbe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:23:20 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:23:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:23:20 INFO - Running setup.py (path:/tmp/pip-ARRwLq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:23:20 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:23:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:23:20 INFO - Running setup.py (path:/tmp/pip-ZmcMyQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:23:20 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:23:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:23:20 INFO - Running setup.py (path:/tmp/pip-R9QJJO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:23:20 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:23:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:23:20 INFO - Running setup.py (path:/tmp/pip-aapFuq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:23: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:23:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:23:21 INFO - Running setup.py (path:/tmp/pip-fwzgGK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:23: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:23:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:23:21 INFO - Running setup.py (path:/tmp/pip-7V65Hb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:23: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:23:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:23:21 INFO - Running setup.py (path:/tmp/pip-Kckddu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:23: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:23:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:23:21 INFO - Running setup.py (path:/tmp/pip-EuGEYR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:23: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:23:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:23:21 INFO - Running setup.py (path:/tmp/pip-R8qZlE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:23: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:23:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:23:21 INFO - Running setup.py (path:/tmp/pip-8WuP2K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:23: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:23:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:23:21 INFO - Running setup.py (path:/tmp/pip-KF4TpT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:23: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:23:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:23:21 INFO - Running setup.py (path:/tmp/pip-0s0fYI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:23: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:23: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:23: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:23: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:23: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:23: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:23:21 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:23: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:23: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:23: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:23: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:23: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:23: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:23:23 INFO - Downloading blessings-1.6.tar.gz 06:23:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:23:23 INFO - Installing collected packages: blessings 06:23:23 INFO - Running setup.py install for blessings 06:23:23 INFO - Successfully installed blessings 06:23:23 INFO - Cleaning up... 06:23:23 INFO - Return code: 0 06:23:23 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:23:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:23:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:23:24 INFO - Reading from file tmpfile_stdout 06:23:24 INFO - Current package versions: 06:23:24 INFO - argparse == 1.2.1 06:23:24 INFO - blessings == 1.6 06:23:24 INFO - blobuploader == 1.2.4 06:23:24 INFO - docopt == 0.6.1 06:23:24 INFO - functools32 == 3.2.3-2 06:23:24 INFO - jsonschema == 2.5.1 06:23:24 INFO - manifestparser == 1.1 06:23:24 INFO - mozInstall == 1.12 06:23:24 INFO - mozcrash == 0.17 06:23:24 INFO - mozdebug == 0.1 06:23:24 INFO - mozdevice == 0.48 06:23:24 INFO - mozfile == 1.2 06:23:24 INFO - mozhttpd == 0.7 06:23:24 INFO - mozinfo == 0.9 06:23:24 INFO - mozleak == 0.1 06:23:24 INFO - mozlog == 3.4 06:23:24 INFO - moznetwork == 0.27 06:23:24 INFO - mozprocess == 0.23 06:23:24 INFO - mozprofile == 0.28 06:23:24 INFO - mozrunner == 6.12 06:23:24 INFO - mozscreenshot == 0.1 06:23:24 INFO - mozsystemmonitor == 0.3 06:23:24 INFO - moztest == 0.7 06:23:24 INFO - mozversion == 1.4 06:23:24 INFO - psutil == 3.1.1 06:23:24 INFO - requests == 1.2.3 06:23:24 INFO - wsgiref == 0.1.2 06:23:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:23: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:23:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:23:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:23: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:23:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:23:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:23: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 0x7f0d817b9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e6a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f37790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f34930>, '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 0x1f35830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f35cc0>, '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': 'fa44defc139c4ba8574fe040000001db-1476881895.368588-165433251', '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:23: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:23: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:23:24 INFO - Using env: {'DISPLAY': ':0', 06:23:24 INFO - 'HOME': '/home/cltbld', 06:23:24 INFO - 'LANG': 'en_US.UTF-8', 06:23:24 INFO - 'LANGUAGE': 'en_US:en', 06:23:24 INFO - 'LOGNAME': 'cltbld', 06:23:24 INFO - 'MAIL': '/var/mail/cltbld', 06:23:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:23:24 INFO - 'MOZ_NO_REMOTE': '1', 06:23:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:23:24 INFO - 'NO_EM_RESTART': '1', 06:23:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:23:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:23:24 INFO - 'PWD': '/builds/slave/test', 06:23:24 INFO - 'SHELL': '/bin/bash', 06:23:24 INFO - 'SHLVL': '1', 06:23:24 INFO - 'TERM': 'linux', 06:23:24 INFO - 'TMOUT': '86400', 06:23:24 INFO - 'USER': 'cltbld', 06:23:24 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1476881895.368588-165433251', 06:23:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:23:24 INFO - '_': '/tools/buildbot/bin/python'} 06:23:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:23: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:23: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:23: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:23: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:23: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:23: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:23: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:23: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:23: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:23: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:23: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:23:24 INFO - Cleaning up... 06:23:24 INFO - Return code: 0 06:23:24 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:23: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:23:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:23:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:23: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:23:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:23:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:23: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 0x7f0d817b9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e6a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f37790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f34930>, '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 0x1f35830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f35cc0>, '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': 'fa44defc139c4ba8574fe040000001db-1476881895.368588-165433251', '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:23: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:23: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:23:24 INFO - Using env: {'DISPLAY': ':0', 06:23:24 INFO - 'HOME': '/home/cltbld', 06:23:24 INFO - 'LANG': 'en_US.UTF-8', 06:23:24 INFO - 'LANGUAGE': 'en_US:en', 06:23:24 INFO - 'LOGNAME': 'cltbld', 06:23:24 INFO - 'MAIL': '/var/mail/cltbld', 06:23:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:23:24 INFO - 'MOZ_NO_REMOTE': '1', 06:23:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:23:24 INFO - 'NO_EM_RESTART': '1', 06:23:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:23:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:23:24 INFO - 'PWD': '/builds/slave/test', 06:23:24 INFO - 'SHELL': '/bin/bash', 06:23:24 INFO - 'SHLVL': '1', 06:23:24 INFO - 'TERM': 'linux', 06:23:24 INFO - 'TMOUT': '86400', 06:23:24 INFO - 'USER': 'cltbld', 06:23:24 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1476881895.368588-165433251', 06:23:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:23:24 INFO - '_': '/tools/buildbot/bin/python'} 06:23:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:23:24 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:23:24 INFO - Cleaning up... 06:23:24 INFO - Return code: 0 06:23:24 INFO - Running post-action listener: _resource_record_post_action 06:23:24 INFO - Running post-action listener: _start_resource_monitoring 06:23:24 INFO - Starting resource monitoring. 06:23:24 INFO - [mozharness: 2016-10-19 13:23:24.531919Z] Finished create-virtualenv step (success) 06:23:24 INFO - [mozharness: 2016-10-19 13:23:24.532529Z] Running install step. 06:23:24 INFO - Running pre-action listener: _resource_record_pre_action 06:23:24 INFO - Running main action method: install 06:23:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:23:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:23:24 INFO - Reading from file tmpfile_stdout 06:23:24 INFO - Detecting whether we're running mozinstall >=1.0... 06:23:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:23:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:23:24 INFO - Reading from file tmpfile_stdout 06:23:24 INFO - Output received: 06:23:24 INFO - Usage: mozinstall [options] installer 06:23:24 INFO - Options: 06:23:24 INFO - -h, --help show this help message and exit 06:23:24 INFO - -d DEST, --destination=DEST 06:23:24 INFO - Directory to install application into. [default: 06:23:24 INFO - "/builds/slave/test"] 06:23:24 INFO - --app=APP Application being installed. [default: firefox] 06:23:24 INFO - mkdir: /builds/slave/test/build/application 06:23:24 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:23:24 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:23:41 INFO - Reading from file tmpfile_stdout 06:23:41 INFO - Output received: 06:23:41 INFO - /builds/slave/test/build/application/firefox/firefox 06:23:41 INFO - Running post-action listener: _resource_record_post_action 06:23:41 INFO - [mozharness: 2016-10-19 13:23:41.781943Z] Finished install step (success) 06:23:41 INFO - [mozharness: 2016-10-19 13:23:41.782190Z] Running run-tests step. 06:23:41 INFO - Running pre-action listener: _resource_record_pre_action 06:23:41 INFO - Running main action method: run_tests 06:23:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:23:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:23:41 INFO - Python 2.7.3 06:23:41 INFO - Return code: 0 06:23:41 INFO - grabbing minidump binary from tooltool 06:23:41 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:23:41 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 0x1f34930>, '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 0x1f35830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f35cc0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:23:41 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:23:41 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:23:41 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:23:41 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:23:41 INFO - Return code: 0 06:23:41 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:23:41 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:23:41 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:23:41 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:23:41 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:23:41 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/cNTRzk_8ST6jwfySUbuL_Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-048', '--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:23:41 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/cNTRzk_8ST6jwfySUbuL_Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-048 --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:23:41 INFO - Using env: {'DISPLAY': ':0', 06:23:41 INFO - 'HOME': '/home/cltbld', 06:23:41 INFO - 'LANG': 'en_US.UTF-8', 06:23:41 INFO - 'LANGUAGE': 'en_US:en', 06:23:41 INFO - 'LOGNAME': 'cltbld', 06:23:41 INFO - 'MAIL': '/var/mail/cltbld', 06:23:41 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:23:41 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:23:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:23:41 INFO - 'MOZ_NO_REMOTE': '1', 06:23:41 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:23:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:23:41 INFO - 'NO_EM_RESTART': '1', 06:23:41 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:23:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:23:41 INFO - 'PWD': '/builds/slave/test', 06:23:41 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:23:41 INFO - 'SHELL': '/bin/bash', 06:23:41 INFO - 'SHLVL': '1', 06:23:41 INFO - 'TERM': 'linux', 06:23:41 INFO - 'TMOUT': '86400', 06:23:41 INFO - 'USER': 'cltbld', 06:23:41 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1476881895.368588-165433251', 06:23:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:23:41 INFO - '_': '/tools/buildbot/bin/python'} 06:23:41 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/cNTRzk_8ST6jwfySUbuL_Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-048', '--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:23:42 INFO - mozversion application_buildid: 20161019033001 06:23:42 INFO - mozversion application_changeset: e4282badddda00fb555bd2e5300c92149434a884 06:23:42 INFO - mozversion application_display_name: Nightly 06:23:42 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:23:42 INFO - mozversion application_name: Firefox 06:23:42 INFO - mozversion application_remotingname: firefox 06:23:42 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 06:23:42 INFO - mozversion application_vendor: Mozilla 06:23:42 INFO - mozversion application_version: 52.0a1 06:23:42 INFO - mozversion platform_buildid: 20161019033001 06:23:42 INFO - mozversion platform_changeset: e4282badddda00fb555bd2e5300c92149434a884 06:23:42 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 06:23:42 INFO - mozversion platform_version: 52.0a1 06:23:42 INFO - using testdate: 1476883422 06:23:42 INFO - actual date: 1476883422 06:23:42 INFO - starting webserver on 'localhost:57258' 06:23:42 INFO - SUITE-START | Running 2 tests 06:23:42 INFO - TEST-START | dromaeo_css 06:23:42 INFO - operating with platform_type : linux_ 06:23:42 INFO - Initialising browser for dromaeo_css test... 06:23:42 INFO - TEST-INFO | started process 26124 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp46mlQs/profile http://localhost:57258/getInfo.html) 06:23:46 INFO - PROCESS | 26124 | __metrics Screen width/height:1600/1200 06:23:46 INFO - PROCESS | 26124 | colorDepth:24 06:23:46 INFO - PROCESS | 26124 | Browser inner width/height: 1024/697 06:23:46 INFO - PROCESS | 26124 | __metrics 06:23:46 INFO - PROCESS | 26124 | 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:23:46 INFO - PROCESS | 26124 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:23:47 INFO - PROCESS | 26124 | console.error: PushService: 06:23:47 INFO - PROCESS | 26124 | stateChangeProcessEnqueue: Error transitioning state 06:23:47 INFO - PROCESS | 26124 | UnknownError 06:23:48 INFO - TEST-INFO | 26124: exit 0 06:23:48 INFO - Browser initialized. 06:23:48 INFO - Running cycle 1/1 for dromaeo_css test... 06:23:48 INFO - TEST-INFO | started process 26210 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp46mlQs/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:24:00 INFO - PROCESS | 26210 | RSS: Main: 172322816 06:24:00 INFO - PROCESS | 26210 | 06:24:52 INFO - PROCESS | 26210 | 1476883492221 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:27:02 INFO - PROCESS | 26210 | Cycle 1(1): loaded http://localhost:57258/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57258/tests/dromaeo/cssquery-ext.html) 06:27:04 INFO - PROCESS | 26210 | RSS: Main: 272916480 06:27:04 INFO - PROCESS | 26210 | 06:30:06 INFO - PROCESS | 26210 | Cycle 1(1): loaded http://localhost:57258/tests/dromaeo/cssquery-ext.html (next: http://localhost:57258/tests/dromaeo/cssquery-jquery.html) 06:30:07 INFO - PROCESS | 26210 | RSS: Main: 282509312 06:30:07 INFO - PROCESS | 26210 | 06:33:09 INFO - PROCESS | 26210 | Cycle 1(1): loaded http://localhost:57258/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57258/tests/dromaeo/cssquery-mootools.html) 06:33:09 INFO - PROCESS | 26210 | RSS: Main: 213835776 06:33:09 INFO - PROCESS | 26210 | 06:36:11 INFO - PROCESS | 26210 | Cycle 1(1): loaded http://localhost:57258/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57258/tests/dromaeo/cssquery-prototype.html) 06:36:12 INFO - PROCESS | 26210 | RSS: Main: 242188288 06:36:12 INFO - PROCESS | 26210 | 06:39:15 INFO - PROCESS | 26210 | Cycle 1(1): loaded http://localhost:57258/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57258/tests/dromaeo/cssquery-yui.html) 06:39:15 INFO - PROCESS | 26210 | RSS: Main: 214523904 06:39:15 INFO - PROCESS | 26210 | 06:42:18 INFO - PROCESS | 26210 | Cycle 1(1): loaded http://localhost:57258/tests/dromaeo/cssquery-yui.html (next: http://localhost:57258/tests/dromaeo/cssquery-dojo.html) 06:42:19 INFO - PROCESS | 26210 | RSS: Main: 306319360 06:42:19 INFO - PROCESS | 26210 | 06:42:19 INFO - PROCESS | 26210 | __start_tp_report 06:42:19 INFO - PROCESS | 26210 | _x_x_mozilla_page_load 06:42:19 INFO - PROCESS | 26210 | _x_x_mozilla_page_load_details 06:42:19 INFO - PROCESS | 26210 | |i|pagename|runs| 06:42:19 INFO - PROCESS | 26210 | |0;dojo.html;3085.52174412966;3094.180042288794;3098.2719061020657;3126.2809553802613;3147.9213019674507;5175.560077393417;5287.048331300364;5327.573794096473;5414.160805075215;5439.972800135999;5310.973445132769;5325.20121981703;5332.626716129873;5333.973330133344;5337.279467271917;4855.611551075923;4910.06708725341;4913.557779799818;4989.326440930464;4991.650584459089;4910.067087253428;4911.8772030699165;4955.207166853304;4971.229459433775;5010.448850626428;4257.233697934371;4920.852374428773;4977.427595826472;4987.077390682735;4990.101781679296;4944.505549445063;4968.1554135797005;4995.350604421402;5008.273800298936;5029.270755740434;4729.219678753002;4770.1175282572485;4770.666053376265;4813.807447702087;4890.168671325883;5322.654027488201;5418.133098704188;5420.945790542123;5425.728713564306;5428.077226871442;5677.489025987681;5701.201831743518;5714.1428785682065;5724.141378793172;5724.398938111522;5731.828045158611;5738.799142030009;5744.741486633112;5745.942540574582;5761.3950535194035;5175.120229560984;5222.216667499905;5331.466853314638;5390.4879036491475;5391.299131113009;5883.558733095035;5883.852903677357;5887.11693246008;5887.440693134231;5946.048632218824;5642.294713160855;5650.180723795109;5653.575981801381;5658.85852853682;5661.2923384576925;5462.262594549765;5503.972480137573;5626.718664066781;5662.348829884533;5677.971610142005;5711.086226203787;5712.34308054579;5745.9712701437065;5752.338481074647;5780.71096445176;5717.514011309086;5719.57103217252;5731.971340143273;5732.3407808101765;5732.369439361667;4288.120935208275;4335.761533115646;4336.718113322624;4417.734935903856;4430.667699922518;3892.6885849132;3921.5490218624655;3948.664363529132;3985.621365970228;3988.0428697113066;5424.891502170013;5427.565794736491;5432.185172224119;5438.428964958623;5484.698341591171;5686.5735069869925;5698.202251684767;5703.201551782754;5723.599348045597;5746.569007324468;5234.26720259164;5268.736563171826;5322.068637988336;5336.733163341817;5463.426340234298;4954.355933728592;4960;4960.578350840219;4998.325226094504;5014;5921.348651648315;5922.052471604695;5937.287525496881;5937.584369094122;5940.851478712981;5443.7822487100075;5476.808311709071;5670.461306175906;5749.408794739507;5823.922574323764;5851.444112809277;5905.350411454822;5918;5961.672108033927;5964.522838172849;5582.246396736388;5621.803236886853;5628.465295796893;5632.380438151882;5637;5538.944610553843;5588.972055139699;5659;5718.656880587178;5724.4561766632105;5527.53015993645;5558.416366281483;5579.665220086646;5587.972060139673;5662.320521537442;5559.777608895599;5563.443655634566;5569.164625306236;5570.637908535932;5570.997220500349;5404.432534583812;5558.972205138948;5567.693776842312;5569.415211402907;5635.351934527582;5466.863328416822;5545.750441230235;5574.470425309589;5601.5238704710555;5700.030994730822;5448.56411487088;5478.780848766005;5490.341159060778;5494.587905906993;5566.4990150886615 06:42:19 INFO - PROCESS | 26210 | |1;ext.html;553.790242331303;584.4389386189258;602.7679343452769;603.3513972479584;613.279396708867;31103;32012.67987320126;34208.48687269693;34213;34269.31461370774;34502.82748586254;43358.566414335844;44086.55913440865;44286.55713442864;47449.28826067603;8730.126987301282;8857.202851743341;8857.645694172226;8865.06916773739;8866.689665861664;8695.782605434852;8770.824583508325;8785.253253473462;8785.692500762474;8791.78020549485;8855.77860553488;8895.243904268113;8904.465732056098;8905.95547022264;8906.910930890705;8765.474071555695;8814.735557933273;8816.20654141124;8820.647174113028;8823.602937867812;8793.648254069829;8847.159519845605;8853.911460885372;8855.07021762712;8856.158664926821;40106.39840402397;40897.386539201936;40915.18169636591;40938.72490200806;40941.79529102335;3082.568440418343;3162.055335968386;3553.626869178725;3808.428735689641;3908.3160446921675;29786.55320170199;31126.377472450426;31818.522722159185;31901;32113.357732845212;4200.600942910419;4276.700630955803;4297.484301883794;4406.471223453206;4516.18708632446;299709.54502052214;301525;301795.9999999978;301901;302481;57666;57796;57837.421625784045;58180.709096454244;58258.4174158253;61260.693696531234;61305.949815770866;61483.38516614866;61523;61523.6923815378;14049.859501405059;14458.638534036523;15002.924985375003;15217.771733424008;15239;11274.210805243718;11466;11481.368524731053;11507.07943364529;11509.194356395139;18615;18648.81351186498;18690.15894284733;18704.9712265824;18818.81181188198;7126.714931402789;7178.38983686382;7194.424446044304;7283.4537409694485;7359.595222262827;924.255973940984;971.8493633486821;992.0625009366224;1030.1038096855784;1032.2155162076726;31503.84248078791;31722;31769;31877.840610796797;32254.645622841086;940.6848705683536;1055.3826011783192;1080.4975686305906;1103.8089392555771;1126.7408496045791;15266.099441106155;17050.016247156946;17084.829151708323;17117.315307387813;17173;481387;492804;495351;495989;496402;57231.71384143136;57986;58153;58247.70876145592;58308.70845645745;1267.4233223883111;1288.4652869059423;1305.9477620895059;1351.148776270943;1362.50949658123;30339.848300759237;31924.36151277008;32629.34741305113;32724.509132362557;33279.168020799676;49186.75406622944;49814.750926245135;49826.25260621021;49873.251901220785;49911.75044124756;388149;391119;392106;392608;393034;40969;41616.79191604022;42274.577254227064;44336.556634434535;44789.552104478535;46630;46816.53183468122;46842;47041.52958470371;48057.5194248053;39088.21823563456;39476.40785388164;40895.591044089175;41051.58948410478;41249.381259281734;39930.80034599925;39951.60048399595;40658.59341406548;40922.1815563693;42084;40606.187876242904;40999.1800164001;41341;41463;41493.377599336636;33710.32579348448;36044.4593331095;36179.81910090433;36802.055835532556;37112.81443592765;27349.316267093483;27546.311342215802;27726.306842328297;28087;29261.26846828761 06:42:19 INFO - PROCESS | 26210 | |2;jquery.html;360.3567631777278;368.1973298209903;380.66235249333835;381.24893958900964;412.35672351132234;14088.225147616877;17696.734548981774;18765;19088.427347179608;20100.59798804023;17355.305787768506;17499.737503937453;17524.21141048653;17539;18395.540111497186;5444.128939369702;5724.7137643117885;5725.2843394575675;5728.484436400723;5730.968425683375;4087.979560102195;4300.548442413548;5592.748326325304;6037.879242415149;6299.590526615778;6387.712552935106;6409.903851442232;6422.646754428504;6422.839429014265;6432.131662225586;5441.156620723775;5671.7447714852515;5672.234248376478;5696.547380417987;5751.568632352591;5403.891922161574;5547.389787123413;5577.3028371453565;5577.581681373873;5578.3584887738025;13375.866241337559;13607.251601161932;13631.318434078257;13714;17687.646247074987;2122.3632910127053;2144.035184167131;2250.493638931244;2798.8460634665084;2918.897838575661;9885.75285617858;9929.75175620608;10063.69808905734;10222.6422075227;10539.262251642389;1831.8168183181708;1902.838258748008;1904.228787341129;1920.6734855074671;1966.7639883213963;75153.24846751516;78730;79582;81229.59385203096;82256;10361.171106311476;10563.154947604173;10707.839382409271;11018.50416731249;11060.557577696802;15070.924645376703;15121.243937803285;15154.242287885561;15165.09009459436;15212.46756363522;7242.239564845615;7607.961960190164;7649.703909379048;7677.808054798563;7821.569813660303;7254.574709427351;7272.090988626422;7273.454490913097;7451.1431185413285;7453.7391191309125;4600.42494688164;4607.723536587815;4624.560666736655;4644.210484217691;4674.602658773974;1898.8986387894988;1922.08700867087;1928.7396201512897;1933.3233368320975;1947.20164732459;722.241646271413;782.969671005004;824.756696774453;916.9037251088673;971.8347880860271;18237.7264341035;18505.259789608535;19274.71087933682;19485.610287794447;19850.801491985185;957.2868213181224;981.5484876956538;982.4252812104999;1009.6012075230243;1060.925735198544;10420.635277765241;10735.302205356627;10881.727956801144;10958;11024.669259922215;415253;416019;426773;428746;429810;79376.20623793804;82348.47121403008;85900;88663.55668221747;91396;985.1478471122427;1005.7950108190087;1013.3362647465922;1013.6502906497394;1016.481594386868;17260.568485787455;17507.649847003242;17979.370722024665;18197.18112684906;18468.44594662162;41477.58522414737;41798.373024405264;43156.352654709575;43227;44884.14527457747;54500.45499544954;55130.44869551413;55910.88178236494;60704.0732668124;65030;11726.530938762355;11939.641810745692;12652.86124248822;12803.61589152327;12851;14147.151170929777;14426;14486.420543178576;14520.346584403938;14597.489087881873;12124.333161676192;12309.93845030805;12338.3830808461;12594.433250503933;12649.24104553693;11928.701782455508;11932.880671193177;11957.820632690342;12315.93842030784;12376.257424554555;12471;12561.937190313989;12589.552201496579;12878.549250776177;12963.740725185633;12634;12640.74718505643;12706.618801435972;12833.42249598789;13256.469741210629;12548.874511254771;12600.495980160691;12720.6819829505;12875;12926.095173337777 06:42:19 INFO - PROCESS | 26210 | |3;mootools.html;1442.8196475440566;1492.1196494068497;1626.9267882945267;1741.1468380493561;1799.7480352750617;8142.185781421855;8827.646894124244;8841.646334146642;8847.734567962963;8849.955750221256;7577.621118944045;7847;8219.50682959023;8455.069942306342;8459.83080338393;2307.59617067013;2311.6648086027517;2311.768823117683;2329.4642232286583;2331.892351133215;2280.6236970899863;2310.1914329984456;2326.150954901457;2338.4855331827057;2342.6837376954063;2009.357005758158;2068.2037415595028;2235.396442960408;2289.6222123349626;2291.175176936302;2235.284708893155;2240.6526988316755;2269.6482045283005;2270.6707527408516;2271.4207876991263;2294.3346429535413;2295.2425699519117;2299.3906614747107;2301.5396920615945;2304.43541332373;8474.576271186415;8607.225349718492;8642.65429382824;8646.870296945552;8663.090375510543;5098.158803797369;5187.896242075138;5219.138842091051;5258.710770907599;5264.473552644743;3173.079806856009;3224.8548815303366;3386.2380964283084;3388.525606415104;3391.6438773928876;1069.893010698924;1069.919756018294;1083.6044843632096;1093.907017903479;1098.906592939601;11676.416179191006;11721.35532545701;11727.7068073298;11729.120315976335;11794.646160615195;4258.638015768633;4402.889927751832;4508.661850361236;4599.793009314589;4617.8845528861375;10011.048950349705;10054.798904021878;10059.195264378832;10068.597256109673;10075.546600402853;5073.543381095719;5113.437521872591;5118.411382690963;5118.641695081383;5130;4608.562186592336;4727.936214351744;4743.881402964954;4771.284307353924;4783.784729687172;3665.157013886768;3750.6061863504483;3766.133789228493;3769.754965927206;3813.904652383713;1220.6155061155707;1272.0840994483956;1275.0609844308956;1282.2562913510142;1289.5873320537337;722.5447967780265;809.5911564659809;940.576740466779;950.296780382512;950.8288508068614;5211.713355765393;5510.1459273812625;5578.888422231533;5584.91622625661;5599.776008959596;939.3847030195233;947.7677968897526;949.7768024514234;977.6236149082512;984.8276551603584;3624.257027309395;3798.5441746989986;3805.1058001369656;3807.961920380816;3855.4602355670227;10371.118454931264;10787.460626968621;10793.730156746144;10795.244332896778;10796.352218866894;10600.204984626183;10688.465576721133;10694.411807350514;10699.518521666543;10701.304415213142;7586.431017673807;8014.038315402189;8083.7170699025255;8100.311473524816;8100.918990810016;5709.771609135588;5756.165356023437;5970.373110823301;5975;6088.634681919099;9320.860187097063;9399.436033837992;9497.14525692691;9561.235101191749;9578.23374130054;9671.274654401088;9940.155086817702;10033.09702126812;10081.69754907354;10224.437655928697;7637.427192960439;7711.807204819925;7802.843943120993;7804.024496937883;7804.2585954334245;8355;8368.581570921308;8384.706535271236;8386.32909367237;8388.622511987098;7449.813754656177;7467.43994200448;7473.43949203801;7595.202503737028;7763.146053934176;7276.090488688914;7290.635468226461;7354.852902942018;7375.188729239672;7413.406927445899;6655.267920528835;6657.567258128206;6703.229128650268;6712.496562757715;6729.495287853332;4732.597729192919;4900.95099049005;4953.331300274417;4978.253262010728;5035.446100928822;4886.755662216946;5002.949970500248;5022;5125.43620201785;5141.28022076902 06:42:19 INFO - PROCESS | 26210 | |4;prototype.html;323.89959112675075;325.92014956335703;335.34440169468684;335.5252317970072;342.3204938197679;5145.3568303962;5239.358645741211;5281.2342210379475;5347.35831700196;5360.981413531431;5176.404713457953;5296.867578310535;5297.708626025567;5300.973495132529;5304.761285742141;4192.7484350938885;4198;4201.159768046387;4202.3696445533105;4230.081243941686;4004.9199016019807;4144.461220041406;4248.299030659953;4249.893752656193;4252.299080367847;4127.298359278915;4134.780239829258;4137.979310103446;4138.255114079465;4138.813753381105;4124.8556300529635;4131.5042194936495;4152.875413737577;4155.7506549606815;4163.646090082347;3678.1724112074835;3687.870924517629;3695.482632431435;3695.593484716679;3702.87039953603;5106.289502850722;5166.535011848914;5171.405288391846;5258.2638430619745;5266.657667251617;4701.858944231644;4708.670393072486;4718.740469274188;4722.244440889475;4775.689580177277;5498.2337797113805;5540.722963851791;5544.140658197945;5551.444855514456;5593.888122237532;3888.202918401721;3968.1865217630607;3985.9800700996598;3986.5614782373914;3997.520297564282;5728.742206600713;5761.567882408836;5773.797917072924;5790.594658373915;5818.825435236908;4110.46563946691;4124.587541245852;4132.553606237792;4132.586741325904;4133.46264985556;3941.5270167580074;4129.566395528486;4136.358864376027;4151.647109995684;4180.853670121531;4723.149833030019;4736.029114031615;4742.762861856893;4746.335513028179;4747.359106520576;5580.888382232332;5613.410591887875;5620.606557541015;5637.605367624227;5664.20701101846;1292.8254685617321;1325.1452812935602;1394.7489451898552;1407.268220525321;1408.3169662713576;881.1973156762662;888.8266787976412;909.3043821476575;911.4323363814229;916.2395211974045;4706.576113301652;4717.622590192776;4719.834805781781;4726.692764970266;4730.361401210793;4984.152694042022;5000.349954505891;5005.370032719792;5024.49755024502;5062.291279220912;4601.309803529497;4699.130660827758;4718.357719676992;4758.500357462417;4795.544423279783;2633.2626864477975;2669.5595226787364;2675.7190494998135;2687.704352521221;2710.7424794644476;5103.014736379259;5106.442535026778;5108.463611320833;5181.409295352324;5217.191335343028;4704.95295047052;4952.034353301072;5033.476566403532;5068.4424713281505;5068.695878247243;5029.396472423333;5098.847034588894;5110.948890511122;5114.820981265638;5141.820036298712;4903.53416425439;4964.67729597575;4989.451160372283;4993.5755460784785;4998.225275082368;4917.28699338601;4929.309896614405;4945.332380128637;5257.2902658140665;5672.461116193955;5889.64662120257;5894.351621321565;5903.2916050072545;5903.439173278532;5924.318703348998;4038.6567141793275;4066.34938409853;4072.7963601819197;4073.287174744467;4075.551689314114;5423.511883930465;5462.781488740406;5719.227904233042;5760.913586296293;5787.131930210502;5461.699606521679;5482.600787511768;5592.273004509388;5612.5509959202345;5633.183188437735;5584.916226256528;5585.441455854382;5601.159826026129;5603.7758489659955;5613.607047506799;5371.785128594813;5597.692126932895;5612.214289999321;5626.493615574618;5630.071038278638;5673.290838645169;5677.489025987681;5683.749575093473;5683.8863222736145;5690.886182276248;5377.435369286325;5454.781808727606;5550.972245138749;5578.609497335147;5585.5531557476115 06:42:19 INFO - PROCESS | 26210 | |5;yui.html;678.8336857469919;737.3097646280366;774.7598244544188;787.3307688464805;798.313897422132;12467.37663116845;12889.677758056054;14759.335829887654;16620.91689541552;16651.500454986355;12814.551490697828;13393.397297121628;13500.12249203801;13590.59228223155;13836.515721949734;793.2900054451262;819.49600995388;831.8627426474654;832.8334333133398;833.5248908122372;673.6261374936909;687.2234375156091;801.8356236971407;819.6270696832927;825.455199568285;860.2000139869918;860.3332417376552;860.4794099569764;860.8579584368572;864.5806783709895;857.6655104509247;859.1751918158575;860.5568132411844;860.6901515454431;860.7805009722543;629.0061702510023;629.408356145222;630.5491573524952;631.3244828034005;631.564220687724;14157.929210353985;14166.92916535421;14171.433142674281;14175.645608859757;14187.716245675132;14561.271936403244;15055.698886022219;15146.924265378713;15290.847091529053;15472.381104755796;11441.885581144164;11553.711157221052;11669.533218671242;12371.381430928417;12728.912319644898;3848.2303539291975;3921.431392448079;3938.4321014106413;3950.3679411294056;3981.1838573092737;78036.60981695112;79598.60200699075;80251.19748802496;80897.59551202206;82227;11665.358405287621;12096.153269271066;12219.938900305619;12385.690357740948;12509;23545.646815297783;23669.644955325683;23901.326907116683;24041.158559450687;24080.87959560191;7822.1004584472375;8042.718504852302;8111.878321825059;8150.2664760171865;8177.95911020453;4305.117450922553;4420.31485119807;4520.52534483881;4611.584957353854;4653.139169253699;3338.132085657698;3379.5099710541836;3390.5253264542985;3408.471686888536;3418.897433076962;597.9760809567568;600.9579329446897;604.1089393145076;612.1766224428137;626.7774939896362;564.8305508347479;600.8978473659488;652.7030201258416;671.9832004199934;693.3759616345329;8484;9125.269978401711;9338.65648324941;9664.71005869825;9749.415035097774;589.8849724303719;622.3589702606323;661.5633681770008;710.9217986021533;719.1083057009271;4654.743989080565;4828.179209534387;4908.656394052454;5216.556592689588;5257;88757.55621221852;119941.40029299798;121249;123832.38083809703;124527;76239.23760762432;78815.60592197003;89327.55336223278;89526;89938;68532;78791.21208787954;79632;80367;83373;8960.372773905765;9549.522523873917;9611.615535378785;9656;9825.263105267277;50998;51065.74467127641;51866.74066629643;53043.93912121813;53931;68830.65584672044;72046.27953720395;72340;74248.25751742629;76829.61585192039;12335.3832308386;12514.499420023098;12550.560730374393;12621.93689031549;13334.666633334244;12984.480620775441;13339.333033348488;13343.599692009255;13845.515406960709;13890.916362545699;13655;13765.793513097111;14180.858191418367;14472.493462728755;14486.348114334669;12588.685282867635;13002.609921702364;14164.150150990974;14423.567292981228;14795.334209960361;12857.871421285667;12999.610011699664;13589.184648921097;13922.303884805922;14058.086224395382;10727.570897164025;11006.944965275123;11077.667669969915;11177.441127943408;11325.490352934303;9723.416595004323;10430.217733669853;11381.317120972768;11464.541418343173;11698.239614425376 06:42:19 INFO - PROCESS | 26210 | __end_tp_report 06:42:19 INFO - PROCESS | 26210 | __start_cc_report 06:42:19 INFO - PROCESS | 26210 | _x_x_mozilla_cycle_collect,1358 06:42:19 INFO - PROCESS | 26210 | __end_cc_report 06:42:19 INFO - PROCESS | 26210 | __startTimestamp1476884539076__endTimestamp 06:42:19 INFO - PROCESS | 26210 | 06:42:19 INFO - PROCESS | 26210 | ------- Summary: start ------- 06:42:19 INFO - PROCESS | 26210 | Number of tests: 6 06:42:19 INFO - PROCESS | 26210 | 06:42:19 INFO - PROCESS | 26210 | [#0] dojo.html Cycles:165 Average:5312.46 Median:5490.34 stddev:593.73 (10.8%) stddev-sans-first:569.27 06:42:19 INFO - PROCESS | 26210 | Values: 3085.5 3094.2 3098.3 3126.3 3147.9 5175.6 5287.0 5327.6 5414.2 5440.0 5311.0 5325.2 5332.6 5334.0 5337.3 4855.6 4910.1 4913.6 4989.3 4991.7 4910.1 4911.9 4955.2 4971.2 5010.4 4257.2 4920.9 4977.4 4987.1 4990.1 4944.5 4968.2 4995.4 5008.3 5029.3 4729.2 4770.1 4770.7 4813.8 4890.2 5322.7 5418.1 5420.9 5425.7 5428.1 5677.5 5701.2 5714.1 5724.1 5724.4 5731.8 5738.8 5744.7 5745.9 5761.4 5175.1 5222.2 5331.5 5390.5 5391.3 5883.6 5883.9 5887.1 5887.4 5946.0 5642.3 5650.2 5653.6 5658.9 5661.3 5462.3 5504.0 5626.7 5662.3 5678.0 5711.1 5712.3 5746.0 5752.3 5780.7 5717.5 5719.6 5732.0 5732.3 5732.4 4288.1 4335.8 4336.7 4417.7 4430.7 3892.7 3921.5 3948.7 3985.6 3988.0 5424.9 5427.6 5432.2 5438.4 5484.7 5686.6 5698.2 5703.2 5723.6 5746.6 5234.3 5268.7 5322.1 5336.7 5463.4 4954.4 4960.0 4960.6 4998.3 5014.0 5921.3 5922.1 5937.3 5937.6 5940.9 5443.8 5476.8 5670.5 5749.4 5823.9 5851.4 5905.4 5918.0 5961.7 5964.5 5582.2 5621.8 5628.5 5632.4 5637.0 5538.9 5589.0 5659.0 5718.7 5724.5 5527.5 5558.4 5579.7 5588.0 5662.3 5559.8 5563.4 5569.2 5570.6 5571.0 5404.4 5559.0 5567.7 5569.4 5635.4 5466.9 5545.8 5574.5 5601.5 5700.0 5448.6 5478.8 5490.3 5494.6 5566.5 06:42:19 INFO - PROCESS | 26210 | 06:42:19 INFO - PROCESS | 26210 | [#1] ext.html Cycles:180 Average:56258.02 Median:40984.09 stddev:106467.76 (259.8%) stddev-sans-first:106684.28 06:42:19 INFO - PROCESS | 26210 | Values: 553.8 584.4 602.8 603.4 613.3 31103.0 32012.7 34208.5 34213.0 34269.3 34502.8 43358.6 44086.6 44286.6 47449.3 8730.1 8857.2 8857.6 8865.1 8866.7 8695.8 8770.8 8785.3 8785.7 8791.8 8855.8 8895.2 8904.5 8906.0 8906.9 8765.5 8814.7 8816.2 8820.6 8823.6 8793.6 8847.2 8853.9 8855.1 8856.2 40106.4 40897.4 40915.2 40938.7 40941.8 3082.6 3162.1 3553.6 3808.4 3908.3 29786.6 31126.4 31818.5 31901.0 32113.4 4200.6 4276.7 4297.5 4406.5 4516.2 299709.5 301525.0 301796.0 301901.0 302481.0 57666.0 57796.0 57837.4 58180.7 58258.4 61260.7 61305.9 61483.4 61523.0 61523.7 14049.9 14458.6 15002.9 15217.8 15239.0 11274.2 11466.0 11481.4 11507.1 11509.2 18615.0 18648.8 18690.2 18705.0 18818.8 7126.7 7178.4 7194.4 7283.5 7359.6 924.3 971.8 992.1 1030.1 1032.2 31503.8 31722.0 31769.0 31877.8 32254.6 940.7 1055.4 1080.5 1103.8 1126.7 15266.1 17050.0 17084.8 17117.3 17173.0 481387.0 492804.0 495351.0 495989.0 496402.0 57231.7 57986.0 58153.0 58247.7 58308.7 1267.4 1288.5 1305.9 1351.1 1362.5 30339.8 31924.4 32629.3 32724.5 33279.2 49186.8 49814.8 49826.3 49873.3 49911.8 388149.0 391119.0 392106.0 392608.0 393034.0 40969.0 41616.8 42274.6 44336.6 44789.6 46630.0 46816.5 46842.0 47041.5 48057.5 39088.2 39476.4 40895.6 41051.6 41249.4 39930.8 39951.6 40658.6 40922.2 42084.0 40606.2 40999.2 41341.0 41463.0 41493.4 33710.3 36044.5 36179.8 36802.1 37112.8 27349.3 27546.3 27726.3 28087.0 29261.3 06:42:19 INFO - PROCESS | 26210 | 06:42:19 INFO - PROCESS | 26210 | [#2] jquery.html Cycles:180 Average:26955.19 Median:10726.19 stddev:70024.11 (652.8%) stddev-sans-first:70192.08 06:42:19 INFO - PROCESS | 26210 | Values: 360.4 368.2 380.7 381.2 412.4 14088.2 17696.7 18765.0 19088.4 20100.6 17355.3 17499.7 17524.2 17539.0 18395.5 5444.1 5724.7 5725.3 5728.5 5731.0 4088.0 4300.5 5592.7 6037.9 6299.6 6387.7 6409.9 6422.6 6422.8 6432.1 5441.2 5671.7 5672.2 5696.5 5751.6 5403.9 5547.4 5577.3 5577.6 5578.4 13375.9 13607.3 13631.3 13714.0 17687.6 2122.4 2144.0 2250.5 2798.8 2918.9 9885.8 9929.8 10063.7 10222.6 10539.3 1831.8 1902.8 1904.2 1920.7 1966.8 75153.2 78730.0 79582.0 81229.6 82256.0 10361.2 10563.2 10707.8 11018.5 11060.6 15070.9 15121.2 15154.2 15165.1 15212.5 7242.2 7608.0 7649.7 7677.8 7821.6 7254.6 7272.1 7273.5 7451.1 7453.7 4600.4 4607.7 4624.6 4644.2 4674.6 1898.9 1922.1 1928.7 1933.3 1947.2 722.2 783.0 824.8 916.9 971.8 18237.7 18505.3 19274.7 19485.6 19850.8 957.3 981.5 982.4 1009.6 1060.9 10420.6 10735.3 10881.7 10958.0 11024.7 415253.0 416019.0 426773.0 428746.0 429810.0 79376.2 82348.5 85900.0 88663.6 91396.0 985.1 1005.8 1013.3 1013.7 1016.5 17260.6 17507.6 17979.4 18197.2 18468.4 41477.6 41798.4 43156.4 43227.0 44884.1 54500.5 55130.4 55910.9 60704.1 65030.0 11726.5 11939.6 12652.9 12803.6 12851.0 14147.2 14426.0 14486.4 14520.3 14597.5 12124.3 12309.9 12338.4 12594.4 12649.2 11928.7 11932.9 11957.8 12315.9 12376.3 12471.0 12561.9 12589.6 12878.5 12963.7 12634.0 12640.7 12706.6 12833.4 13256.5 12548.9 12600.5 12720.7 12875.0 12926.1 06:42:19 INFO - PROCESS | 26210 | 06:42:19 INFO - PROCESS | 26210 | [#3] mootools.html Cycles:180 Average:5628.85 Median:4927.14 stddev:3190.51 (64.8%) stddev-sans-first:3183.95 06:42:19 INFO - PROCESS | 26210 | Values: 1442.8 1492.1 1626.9 1741.1 1799.7 8142.2 8827.6 8841.6 8847.7 8850.0 7577.6 7847.0 8219.5 8455.1 8459.8 2307.6 2311.7 2311.8 2329.5 2331.9 2280.6 2310.2 2326.2 2338.5 2342.7 2009.4 2068.2 2235.4 2289.6 2291.2 2235.3 2240.7 2269.6 2270.7 2271.4 2294.3 2295.2 2299.4 2301.5 2304.4 8474.6 8607.2 8642.7 8646.9 8663.1 5098.2 5187.9 5219.1 5258.7 5264.5 3173.1 3224.9 3386.2 3388.5 3391.6 1069.9 1069.9 1083.6 1093.9 1098.9 11676.4 11721.4 11727.7 11729.1 11794.6 4258.6 4402.9 4508.7 4599.8 4617.9 10011.0 10054.8 10059.2 10068.6 10075.5 5073.5 5113.4 5118.4 5118.6 5130.0 4608.6 4727.9 4743.9 4771.3 4783.8 3665.2 3750.6 3766.1 3769.8 3813.9 1220.6 1272.1 1275.1 1282.3 1289.6 722.5 809.6 940.6 950.3 950.8 5211.7 5510.1 5578.9 5584.9 5599.8 939.4 947.8 949.8 977.6 984.8 3624.3 3798.5 3805.1 3808.0 3855.5 10371.1 10787.5 10793.7 10795.2 10796.4 10600.2 10688.5 10694.4 10699.5 10701.3 7586.4 8014.0 8083.7 8100.3 8100.9 5709.8 5756.2 5970.4 5975.0 6088.6 9320.9 9399.4 9497.1 9561.2 9578.2 9671.3 9940.2 10033.1 10081.7 10224.4 7637.4 7711.8 7802.8 7804.0 7804.3 8355.0 8368.6 8384.7 8386.3 8388.6 7449.8 7467.4 7473.4 7595.2 7763.1 7276.1 7290.6 7354.9 7375.2 7413.4 6655.3 6657.6 6703.2 6712.5 6729.5 4732.6 4901.0 4953.3 4978.3 5035.4 4886.8 5002.9 5022.0 5125.4 5141.3 06:42:19 INFO - PROCESS | 26210 | 06:42:19 INFO - PROCESS | 26210 | [#4] prototype.html Cycles:180 Average:4535.28 Median:4999.29 stddev:1319.95 (26.4%) stddev-sans-first:1285.24 06:42:19 INFO - PROCESS | 26210 | Values: 323.9 325.9 335.3 335.5 342.3 5145.4 5239.4 5281.2 5347.4 5361.0 5176.4 5296.9 5297.7 5301.0 5304.8 4192.7 4198.0 4201.2 4202.4 4230.1 4004.9 4144.5 4248.3 4249.9 4252.3 4127.3 4134.8 4138.0 4138.3 4138.8 4124.9 4131.5 4152.9 4155.8 4163.6 3678.2 3687.9 3695.5 3695.6 3702.9 5106.3 5166.5 5171.4 5258.3 5266.7 4701.9 4708.7 4718.7 4722.2 4775.7 5498.2 5540.7 5544.1 5551.4 5593.9 3888.2 3968.2 3986.0 3986.6 3997.5 5728.7 5761.6 5773.8 5790.6 5818.8 4110.5 4124.6 4132.6 4132.6 4133.5 3941.5 4129.6 4136.4 4151.6 4180.9 4723.1 4736.0 4742.8 4746.3 4747.4 5580.9 5613.4 5620.6 5637.6 5664.2 1292.8 1325.1 1394.7 1407.3 1408.3 881.2 888.8 909.3 911.4 916.2 4706.6 4717.6 4719.8 4726.7 4730.4 4984.2 5000.3 5005.4 5024.5 5062.3 4601.3 4699.1 4718.4 4758.5 4795.5 2633.3 2669.6 2675.7 2687.7 2710.7 5103.0 5106.4 5108.5 5181.4 5217.2 4705.0 4952.0 5033.5 5068.4 5068.7 5029.4 5098.8 5110.9 5114.8 5141.8 4903.5 4964.7 4989.5 4993.6 4998.2 4917.3 4929.3 4945.3 5257.3 5672.5 5889.6 5894.4 5903.3 5903.4 5924.3 4038.7 4066.3 4072.8 4073.3 4075.6 5423.5 5462.8 5719.2 5760.9 5787.1 5461.7 5482.6 5592.3 5612.6 5633.2 5584.9 5585.4 5601.2 5603.8 5613.6 5371.8 5597.7 5612.2 5626.5 5630.1 5673.3 5677.5 5683.7 5683.9 5690.9 5377.4 5454.8 5551.0 5578.6 5585.6 06:42:19 INFO - PROCESS | 26210 | 06:42:19 INFO - PROCESS | 26210 | [#5] yui.html Cycles:180 Average:20248.83 Median:27953.33 stddev:28847.52 (103.2%) stddev-sans-first:28891.02 06:42:19 INFO - PROCESS | 26210 | Values: 678.8 737.3 774.8 787.3 798.3 12467.4 12889.7 14759.3 16620.9 16651.5 12814.6 13393.4 13500.1 13590.6 13836.5 793.3 819.5 831.9 832.8 833.5 673.6 687.2 801.8 819.6 825.5 860.2 860.3 860.5 860.9 864.6 857.7 859.2 860.6 860.7 860.8 629.0 629.4 630.5 631.3 631.6 14157.9 14166.9 14171.4 14175.6 14187.7 14561.3 15055.7 15146.9 15290.8 15472.4 11441.9 11553.7 11669.5 12371.4 12728.9 3848.2 3921.4 3938.4 3950.4 3981.2 78036.6 79598.6 80251.2 80897.6 82227.0 11665.4 12096.2 12219.9 12385.7 12509.0 23545.6 23669.6 23901.3 24041.2 24080.9 7822.1 8042.7 8111.9 8150.3 8178.0 4305.1 4420.3 4520.5 4611.6 4653.1 3338.1 3379.5 3390.5 3408.5 3418.9 598.0 601.0 604.1 612.2 626.8 564.8 600.9 652.7 672.0 693.4 8484.0 9125.3 9338.7 9664.7 9749.4 589.9 622.4 661.6 710.9 719.1 4654.7 4828.2 4908.7 5216.6 5257.0 88757.6 119941.4 121249.0 123832.4 124527.0 76239.2 78815.6 89327.6 89526.0 89938.0 68532.0 78791.2 79632.0 80367.0 83373.0 8960.4 9549.5 9611.6 9656.0 9825.3 50998.0 51065.7 51866.7 53043.9 53931.0 68830.7 72046.3 72340.0 74248.3 76829.6 12335.4 12514.5 12550.6 12621.9 13334.7 12984.5 13339.3 13343.6 13845.5 13890.9 13655.0 13765.8 14180.9 14472.5 14486.3 12588.7 13002.6 14164.2 14423.6 14795.3 12857.9 12999.6 13589.2 13922.3 14058.1 10727.6 11006.9 11077.7 11177.4 11325.5 9723.4 10430.2 11381.3 11464.5 11698.2 06:42:19 INFO - PROCESS | 26210 | -------- Summary: end -------- 06:42:19 INFO - PROCESS | 26210 | 06:42:20 INFO - TEST-INFO | 26210: exit 0 06:42:20 INFO - TEST-OK | dromaeo_css | took 1118031ms 06:42:20 INFO - TEST-START | kraken 06:42:20 INFO - operating with platform_type : linux_ 06:42:20 INFO - Initialising browser for kraken test... 06:42:20 INFO - TEST-INFO | started process 26518 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAmb4lv/profile http://localhost:57258/getInfo.html) 06:42:24 INFO - PROCESS | 26518 | __metrics Screen width/height:1600/1200 06:42:24 INFO - PROCESS | 26518 | colorDepth:24 06:42:24 INFO - PROCESS | 26518 | Browser inner width/height: 1024/697 06:42:24 INFO - PROCESS | 26518 | __metrics 06:42:24 INFO - PROCESS | 26518 | 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:42:24 INFO - PROCESS | 26518 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:42:25 INFO - PROCESS | 26518 | console.error: PushService: 06:42:25 INFO - PROCESS | 26518 | stateChangeProcessEnqueue: Error transitioning state 06:42:25 INFO - PROCESS | 26518 | UnknownError 06:42:26 INFO - TEST-INFO | 26518: exit 0 06:42:26 INFO - Browser initialized. 06:42:26 INFO - Running cycle 1/1 for kraken test... 06:42:26 INFO - TEST-INFO | started process 26603 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAmb4lv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:42:38 INFO - PROCESS | 26603 | RSS: Main: 171950080 06:42:38 INFO - PROCESS | 26603 | 06:42:40 INFO - PROCESS | 26603 | Cycle 1(1): loaded http://localhost:57258/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57258/tests/kraken/driver.html?testName=audio-beat-detection) 06:42:41 INFO - PROCESS | 26603 | RSS: Main: 229175296 06:42:41 INFO - PROCESS | 26603 | 06:42:44 INFO - PROCESS | 26603 | Cycle 1(1): loaded http://localhost:57258/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57258/tests/kraken/driver.html?testName=audio-dft) 06:42:44 INFO - PROCESS | 26603 | RSS: Main: 216702976 06:42:44 INFO - PROCESS | 26603 | 06:42:48 INFO - PROCESS | 26603 | Cycle 1(1): loaded http://localhost:57258/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57258/tests/kraken/driver.html?testName=audio-fft) 06:42:48 INFO - PROCESS | 26603 | RSS: Main: 298033152 06:42:48 INFO - PROCESS | 26603 | 06:42:50 INFO - PROCESS | 26603 | Cycle 1(1): loaded http://localhost:57258/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57258/tests/kraken/driver.html?testName=audio-oscillator) 06:42:51 INFO - PROCESS | 26603 | RSS: Main: 206172160 06:42:51 INFO - PROCESS | 26603 | 06:42:53 INFO - PROCESS | 26603 | Cycle 1(1): loaded http://localhost:57258/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57258/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:42:54 INFO - PROCESS | 26603 | RSS: Main: 211308544 06:42:54 INFO - PROCESS | 26603 | 06:42:57 INFO - PROCESS | 26603 | Cycle 1(1): loaded http://localhost:57258/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57258/tests/kraken/driver.html?testName=imaging-darkroom) 06:42:57 INFO - PROCESS | 26603 | RSS: Main: 248074240 06:42:57 INFO - PROCESS | 26603 | 06:43:00 INFO - PROCESS | 26603 | Cycle 1(1): loaded http://localhost:57258/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57258/tests/kraken/driver.html?testName=imaging-desaturate) 06:43:01 INFO - PROCESS | 26603 | RSS: Main: 247812096 06:43:01 INFO - PROCESS | 26603 | 06:43:04 INFO - PROCESS | 26603 | Cycle 1(1): loaded http://localhost:57258/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57258/tests/kraken/driver.html?testName=json-parse-financial) 06:43:04 INFO - PROCESS | 26603 | RSS: Main: 246988800 06:43:04 INFO - PROCESS | 26603 | 06:43:06 INFO - PROCESS | 26603 | Cycle 1(1): loaded http://localhost:57258/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57258/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:43:06 INFO - PROCESS | 26603 | RSS: Main: 209534976 06:43:06 INFO - PROCESS | 26603 | 06:43:08 INFO - PROCESS | 26603 | Cycle 1(1): loaded http://localhost:57258/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57258/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:43:09 INFO - PROCESS | 26603 | RSS: Main: 216551424 06:43:09 INFO - PROCESS | 26603 | 06:43:11 INFO - PROCESS | 26603 | Cycle 1(1): loaded http://localhost:57258/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57258/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:43:11 INFO - PROCESS | 26603 | RSS: Main: 226185216 06:43:11 INFO - PROCESS | 26603 | 06:43:14 INFO - PROCESS | 26603 | Cycle 1(1): loaded http://localhost:57258/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57258/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:43:15 INFO - PROCESS | 26603 | RSS: Main: 234733568 06:43:15 INFO - PROCESS | 26603 | 06:43:18 INFO - PROCESS | 26603 | Cycle 1(1): loaded http://localhost:57258/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57258/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:43:18 INFO - PROCESS | 26603 | RSS: Main: 232243200 06:43:18 INFO - PROCESS | 26603 | 06:43:20 INFO - PROCESS | 26603 | Cycle 1(1): loaded http://localhost:57258/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57258/tests/kraken/driver.html?testName=ai-astar) 06:43:20 INFO - PROCESS | 26603 | RSS: Main: 281411584 06:43:20 INFO - PROCESS | 26603 | 06:43:20 INFO - PROCESS | 26603 | __start_tp_report 06:43:20 INFO - PROCESS | 26603 | _x_x_mozilla_page_load 06:43:20 INFO - PROCESS | 26603 | _x_x_mozilla_page_load_details 06:43:20 INFO - PROCESS | 26603 | |i|pagename|runs| 06:43:20 INFO - PROCESS | 26603 | |0;ai-astar;103;109;112;117;110;110;110;110;109;109 06:43:20 INFO - PROCESS | 26603 | |1;audio-beat-detection;149;122;123;159;123;124;129;121;158;123 06:43:20 INFO - PROCESS | 26603 | |2;audio-dft;159;161;160;160;160;161;161;161;160;161 06:43:20 INFO - PROCESS | 26603 | |3;audio-fft;74;76;75;108;77;77;76;77;99;76 06:43:20 INFO - PROCESS | 26603 | |4;audio-oscillator;83;83;125;82;82;82;106;84;81;115 06:43:20 INFO - PROCESS | 26603 | |5;imaging-gaussian-blur;117;117;117;117;118;117;118;119;118;118 06:43:20 INFO - PROCESS | 26603 | |6;imaging-darkroom;145;146;146;145;145;145;146;146;147;145 06:43:20 INFO - PROCESS | 26603 | |7;imaging-desaturate;85;85;84;85;86;86;85;86;85;84 06:43:20 INFO - PROCESS | 26603 | |8;json-parse-financial;55;53;54;52;55;55;56;54;55;55 06:43:20 INFO - PROCESS | 26603 | |9;json-stringify-tinderbox;59;59;60;60;59;60;59;63;61;60 06:43:20 INFO - PROCESS | 26603 | |10;stanford-crypto-aes;80;81;79;79;83;86;79;90;80;79 06:43:20 INFO - PROCESS | 26603 | |11;stanford-crypto-ccm;136;135;135;145;132;132;131;130;177;142 06:43:20 INFO - PROCESS | 26603 | |12;stanford-crypto-pbkdf2;169;180;167;167;166;167;165;167;165;167 06:43:20 INFO - PROCESS | 26603 | |13;stanford-crypto-sha256-iterative;66;68;67;65;67;67;66;65;67;66 06:43:20 INFO - PROCESS | 26603 | __end_tp_report 06:43:20 INFO - PROCESS | 26603 | __start_cc_report 06:43:20 INFO - PROCESS | 26603 | _x_x_mozilla_cycle_collect,1706 06:43:20 INFO - PROCESS | 26603 | __end_cc_report 06:43:20 INFO - PROCESS | 26603 | __startTimestamp1476884600663__endTimestamp 06:43:20 INFO - PROCESS | 26603 | 06:43:20 INFO - PROCESS | 26603 | ------- Summary: start ------- 06:43:20 INFO - PROCESS | 26603 | Number of tests: 14 06:43:20 INFO - PROCESS | 26603 | 06:43:20 INFO - PROCESS | 26603 | [#0] ai-astar Cycles:10 Average:109.90 Median:110.00 stddev:3.41 (3.1%) stddev-sans-first:2.55 06:43:20 INFO - PROCESS | 26603 | Values: 103.0 109.0 112.0 117.0 110.0 110.0 110.0 110.0 109.0 109.0 06:43:20 INFO - PROCESS | 26603 | 06:43:20 INFO - PROCESS | 26603 | [#1] audio-beat-detection Cycles:10 Average:133.10 Median:126.50 stddev:15.70 (12.4%) stddev-sans-first:15.56 06:43:20 INFO - PROCESS | 26603 | Values: 149.0 122.0 123.0 159.0 123.0 124.0 129.0 121.0 158.0 123.0 06:43:20 INFO - PROCESS | 26603 | 06:43:20 INFO - PROCESS | 26603 | [#2] audio-dft Cycles:10 Average:160.40 Median:161.00 stddev:0.70 (0.4%) stddev-sans-first:0.53 06:43:20 INFO - PROCESS | 26603 | Values: 159.0 161.0 160.0 160.0 160.0 161.0 161.0 161.0 160.0 161.0 06:43:20 INFO - PROCESS | 26603 | 06:43:20 INFO - PROCESS | 26603 | [#3] audio-fft Cycles:10 Average:81.50 Median:76.50 stddev:11.83 (15.5%) stddev-sans-first:12.23 06:43:20 INFO - PROCESS | 26603 | Values: 74.0 76.0 75.0 108.0 77.0 77.0 76.0 77.0 99.0 76.0 06:43:20 INFO - PROCESS | 26603 | 06:43:20 INFO - PROCESS | 26603 | [#4] audio-oscillator Cycles:10 Average:92.30 Median:82.00 stddev:16.53 (20.2%) stddev-sans-first:17.19 06:43:20 INFO - PROCESS | 26603 | Values: 83.0 83.0 125.0 82.0 82.0 82.0 106.0 84.0 81.0 115.0 06:43:20 INFO - PROCESS | 26603 | 06:43:20 INFO - PROCESS | 26603 | [#5] imaging-gaussian-blur Cycles:10 Average:117.60 Median:118.00 stddev:0.70 (0.6%) stddev-sans-first:0.71 06:43:20 INFO - PROCESS | 26603 | Values: 117.0 117.0 117.0 117.0 118.0 117.0 118.0 119.0 118.0 118.0 06:43:20 INFO - PROCESS | 26603 | 06:43:20 INFO - PROCESS | 26603 | [#6] imaging-darkroom Cycles:10 Average:145.60 Median:146.00 stddev:0.70 (0.5%) stddev-sans-first:0.71 06:43:20 INFO - PROCESS | 26603 | Values: 145.0 146.0 146.0 145.0 145.0 145.0 146.0 146.0 147.0 145.0 06:43:20 INFO - PROCESS | 26603 | 06:43:20 INFO - PROCESS | 26603 | [#7] imaging-desaturate Cycles:10 Average:85.10 Median:85.00 stddev:0.74 (0.9%) stddev-sans-first:0.78 06:43:20 INFO - PROCESS | 26603 | Values: 85.0 85.0 84.0 85.0 86.0 86.0 85.0 86.0 85.0 84.0 06:43:20 INFO - PROCESS | 26603 | 06:43:20 INFO - PROCESS | 26603 | [#8] json-parse-financial Cycles:10 Average:54.40 Median:55.00 stddev:1.17 (2.1%) stddev-sans-first:1.22 06:43:20 INFO - PROCESS | 26603 | Values: 55.0 53.0 54.0 52.0 55.0 55.0 56.0 54.0 55.0 55.0 06:43:20 INFO - PROCESS | 26603 | 06:43:20 INFO - PROCESS | 26603 | [#9] json-stringify-tinderbox Cycles:10 Average:60.00 Median:60.00 stddev:1.25 (2.1%) stddev-sans-first:1.27 06:43:20 INFO - PROCESS | 26603 | Values: 59.0 59.0 60.0 60.0 59.0 60.0 59.0 63.0 61.0 60.0 06:43:20 INFO - PROCESS | 26603 | 06:43:20 INFO - PROCESS | 26603 | [#10] stanford-crypto-aes Cycles:10 Average:81.60 Median:80.50 stddev:3.72 (4.6%) stddev-sans-first:3.90 06:43:20 INFO - PROCESS | 26603 | Values: 80.0 81.0 79.0 79.0 83.0 86.0 79.0 90.0 80.0 79.0 06:43:20 INFO - PROCESS | 26603 | 06:43:20 INFO - PROCESS | 26603 | [#11] stanford-crypto-ccm Cycles:10 Average:139.50 Median:135.50 stddev:14.03 (10.4%) stddev-sans-first:14.82 06:43:20 INFO - PROCESS | 26603 | Values: 136.0 135.0 135.0 145.0 132.0 132.0 131.0 130.0 177.0 142.0 06:43:20 INFO - PROCESS | 26603 | 06:43:20 INFO - PROCESS | 26603 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.00 Median:167.00 stddev:4.37 (2.6%) stddev-sans-first:4.62 06:43:20 INFO - PROCESS | 26603 | Values: 169.0 180.0 167.0 167.0 166.0 167.0 165.0 167.0 165.0 167.0 06:43:20 INFO - PROCESS | 26603 | 06:43:20 INFO - PROCESS | 26603 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.40 Median:67.00 stddev:0.97 (1.4%) stddev-sans-first:1.01 06:43:20 INFO - PROCESS | 26603 | Values: 66.0 68.0 67.0 65.0 67.0 67.0 66.0 65.0 67.0 66.0 06:43:20 INFO - PROCESS | 26603 | -------- Summary: end -------- 06:43:20 INFO - PROCESS | 26603 | 06:43:21 INFO - TEST-INFO | 26603: exit 0 06:43:21 INFO - TEST-OK | kraken | took 61847ms 06:43:21 INFO - SUITE-END | took 1179s 06:43:22 INFO - Completed test suite (00:19:40) 06:43:22 INFO - javascript benchmark 06:43:22 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3085.52174412966, 3094.180042288794, 3098.2719061020657, 3126.2809553802613, 3147.9213019674507, 5175.560077393417, 5287.048331300364, 5327.573794096473, 5414.160805075215, 5439.972800135999, 5310.973445132769, 5325.20121981703, 5332.626716129873, 5333.973330133344, 5337.279467271917, 4855.611551075923, 4910.06708725341, 4913.557779799818, 4989.326440930464, 4991.650584459089, 4910.067087253428, 4911.8772030699165, 4955.207166853304, 4971.229459433775, 5010.448850626428, 4257.233697934371, 4920.852374428773, 4977.427595826472, 4987.077390682735, 4990.101781679296, 4944.505549445063, 4968.1554135797005, 4995.350604421402, 5008.273800298936, 5029.270755740434, 4729.219678753002, 4770.1175282572485, 4770.666053376265, 4813.807447702087, 4890.168671325883, 5322.654027488201, 5418.133098704188, 5420.945790542123, 5425.728713564306, 5428.077226871442, 5677.489025987681, 5701.201831743518, 5714.1428785682065, 5724.141378793172, 5724.398938111522, 5731.828045158611, 5738.799142030009, 5744.741486633112, 5745.942540574582, 5761.3950535194035, 5175.120229560984, 5222.216667499905, 5331.466853314638, 5390.4879036491475, 5391.299131113009, 5883.558733095035, 5883.852903677357, 5887.11693246008, 5887.440693134231, 5946.048632218824, 5642.294713160855, 5650.180723795109, 5653.575981801381, 5658.85852853682, 5661.2923384576925, 5462.262594549765, 5503.972480137573, 5626.718664066781, 5662.348829884533, 5677.971610142005, 5711.086226203787, 5712.34308054579, 5745.9712701437065, 5752.338481074647, 5780.71096445176, 5717.514011309086, 5719.57103217252, 5731.971340143273, 5732.3407808101765, 5732.369439361667, 4288.120935208275, 4335.761533115646, 4336.718113322624, 4417.734935903856, 4430.667699922518, 3892.6885849132, 3921.5490218624655, 3948.664363529132, 3985.621365970228, 3988.0428697113066, 5424.891502170013, 5427.565794736491, 5432.185172224119, 5438.428964958623, 5484.698341591171, 5686.5735069869925, 5698.202251684767, 5703.201551782754, 5723.599348045597, 5746.569007324468, 5234.26720259164, 5268.736563171826, 5322.068637988336, 5336.733163341817, 5463.426340234298, 4954.355933728592, 4960.0, 4960.578350840219, 4998.325226094504, 5014.0, 5921.348651648315, 5922.052471604695, 5937.287525496881, 5937.584369094122, 5940.851478712981, 5443.7822487100075, 5476.808311709071, 5670.461306175906, 5749.408794739507, 5823.922574323764, 5851.444112809277, 5905.350411454822, 5918.0, 5961.672108033927, 5964.522838172849, 5582.246396736388, 5621.803236886853, 5628.465295796893, 5632.380438151882, 5637.0, 5538.944610553843, 5588.972055139699, 5659.0, 5718.656880587178, 5724.4561766632105, 5527.53015993645, 5558.416366281483, 5579.665220086646, 5587.972060139673, 5662.320521537442, 5559.777608895599, 5563.443655634566, 5569.164625306236, 5570.637908535932, 5570.997220500349, 5404.432534583812, 5558.972205138948, 5567.693776842312, 5569.415211402907, 5635.351934527582, 5466.863328416822, 5545.750441230235, 5574.470425309589, 5601.5238704710555, 5700.030994730822, 5448.56411487088, 5478.780848766005, 5490.341159060778, 5494.587905906993, 5566.4990150886615], "value": 5273.286057553946, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [553.790242331303, 584.4389386189258, 602.7679343452769, 603.3513972479584, 613.279396708867, 31103.0, 32012.67987320126, 34208.48687269693, 34213.0, 34269.31461370774, 34502.82748586254, 43358.566414335844, 44086.55913440865, 44286.55713442864, 47449.28826067603, 8730.126987301282, 8857.202851743341, 8857.645694172226, 8865.06916773739, 8866.689665861664, 8695.782605434852, 8770.824583508325, 8785.253253473462, 8785.692500762474, 8791.78020549485, 8855.77860553488, 8895.243904268113, 8904.465732056098, 8905.95547022264, 8906.910930890705, 8765.474071555695, 8814.735557933273, 8816.20654141124, 8820.647174113028, 8823.602937867812, 8793.648254069829, 8847.159519845605, 8853.911460885372, 8855.07021762712, 8856.158664926821, 40106.39840402397, 40897.386539201936, 40915.18169636591, 40938.72490200806, 40941.79529102335, 3082.568440418343, 3162.055335968386, 3553.626869178725, 3808.428735689641, 3908.3160446921675, 29786.55320170199, 31126.377472450426, 31818.522722159185, 31901.0, 32113.357732845212, 4200.600942910419, 4276.700630955803, 4297.484301883794, 4406.471223453206, 4516.18708632446, 299709.54502052214, 301525.0, 301795.9999999978, 301901.0, 302481.0, 57666.0, 57796.0, 57837.421625784045, 58180.709096454244, 58258.4174158253, 61260.693696531234, 61305.949815770866, 61483.38516614866, 61523.0, 61523.6923815378, 14049.859501405059, 14458.638534036523, 15002.924985375003, 15217.771733424008, 15239.0, 11274.210805243718, 11466.0, 11481.368524731053, 11507.07943364529, 11509.194356395139, 18615.0, 18648.81351186498, 18690.15894284733, 18704.9712265824, 18818.81181188198, 7126.714931402789, 7178.38983686382, 7194.424446044304, 7283.4537409694485, 7359.595222262827, 924.255973940984, 971.8493633486821, 992.0625009366224, 1030.1038096855784, 1032.2155162076726, 31503.84248078791, 31722.0, 31769.0, 31877.840610796797, 32254.645622841086, 940.6848705683536, 1055.3826011783192, 1080.4975686305906, 1103.8089392555771, 1126.7408496045791, 15266.099441106155, 17050.016247156946, 17084.829151708323, 17117.315307387813, 17173.0, 481387.0, 492804.0, 495351.0, 495989.0, 496402.0, 57231.71384143136, 57986.0, 58153.0, 58247.70876145592, 58308.70845645745, 1267.4233223883111, 1288.4652869059423, 1305.9477620895059, 1351.148776270943, 1362.50949658123, 30339.848300759237, 31924.36151277008, 32629.34741305113, 32724.509132362557, 33279.168020799676, 49186.75406622944, 49814.750926245135, 49826.25260621021, 49873.251901220785, 49911.75044124756, 388149.0, 391119.0, 392106.0, 392608.0, 393034.0, 40969.0, 41616.79191604022, 42274.577254227064, 44336.556634434535, 44789.552104478535, 46630.0, 46816.53183468122, 46842.0, 47041.52958470371, 48057.5194248053, 39088.21823563456, 39476.40785388164, 40895.591044089175, 41051.58948410478, 41249.381259281734, 39930.80034599925, 39951.60048399595, 40658.59341406548, 40922.1815563693, 42084.0, 40606.187876242904, 40999.1800164001, 41341.0, 41463.0, 41493.377599336636, 33710.32579348448, 36044.4593331095, 36179.81910090433, 36802.055835532556, 37112.81443592765, 27349.316267093483, 27546.311342215802, 27726.306842328297, 28087.0, 29261.26846828761], "value": 19686.73088145187, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [360.3567631777278, 368.1973298209903, 380.66235249333835, 381.24893958900964, 412.35672351132234, 14088.225147616877, 17696.734548981774, 18765.0, 19088.427347179608, 20100.59798804023, 17355.305787768506, 17499.737503937453, 17524.21141048653, 17539.0, 18395.540111497186, 5444.128939369702, 5724.7137643117885, 5725.2843394575675, 5728.484436400723, 5730.968425683375, 4087.979560102195, 4300.548442413548, 5592.748326325304, 6037.879242415149, 6299.590526615778, 6387.712552935106, 6409.903851442232, 6422.646754428504, 6422.839429014265, 6432.131662225586, 5441.156620723775, 5671.7447714852515, 5672.234248376478, 5696.547380417987, 5751.568632352591, 5403.891922161574, 5547.389787123413, 5577.3028371453565, 5577.581681373873, 5578.3584887738025, 13375.866241337559, 13607.251601161932, 13631.318434078257, 13714.0, 17687.646247074987, 2122.3632910127053, 2144.035184167131, 2250.493638931244, 2798.8460634665084, 2918.897838575661, 9885.75285617858, 9929.75175620608, 10063.69808905734, 10222.6422075227, 10539.262251642389, 1831.8168183181708, 1902.838258748008, 1904.228787341129, 1920.6734855074671, 1966.7639883213963, 75153.24846751516, 78730.0, 79582.0, 81229.59385203096, 82256.0, 10361.171106311476, 10563.154947604173, 10707.839382409271, 11018.50416731249, 11060.557577696802, 15070.924645376703, 15121.243937803285, 15154.242287885561, 15165.09009459436, 15212.46756363522, 7242.239564845615, 7607.961960190164, 7649.703909379048, 7677.808054798563, 7821.569813660303, 7254.574709427351, 7272.090988626422, 7273.454490913097, 7451.1431185413285, 7453.7391191309125, 4600.42494688164, 4607.723536587815, 4624.560666736655, 4644.210484217691, 4674.602658773974, 1898.8986387894988, 1922.08700867087, 1928.7396201512897, 1933.3233368320975, 1947.20164732459, 722.241646271413, 782.969671005004, 824.756696774453, 916.9037251088673, 971.8347880860271, 18237.7264341035, 18505.259789608535, 19274.71087933682, 19485.610287794447, 19850.801491985185, 957.2868213181224, 981.5484876956538, 982.4252812104999, 1009.6012075230243, 1060.925735198544, 10420.635277765241, 10735.302205356627, 10881.727956801144, 10958.0, 11024.669259922215, 415253.0, 416019.0, 426773.0, 428746.0, 429810.0, 79376.20623793804, 82348.47121403008, 85900.0, 88663.55668221747, 91396.0, 985.1478471122427, 1005.7950108190087, 1013.3362647465922, 1013.6502906497394, 1016.481594386868, 17260.568485787455, 17507.649847003242, 17979.370722024665, 18197.18112684906, 18468.44594662162, 41477.58522414737, 41798.373024405264, 43156.352654709575, 43227.0, 44884.14527457747, 54500.45499544954, 55130.44869551413, 55910.88178236494, 60704.0732668124, 65030.0, 11726.530938762355, 11939.641810745692, 12652.86124248822, 12803.61589152327, 12851.0, 14147.151170929777, 14426.0, 14486.420543178576, 14520.346584403938, 14597.489087881873, 12124.333161676192, 12309.93845030805, 12338.3830808461, 12594.433250503933, 12649.24104553693, 11928.701782455508, 11932.880671193177, 11957.820632690342, 12315.93842030784, 12376.257424554555, 12471.0, 12561.937190313989, 12589.552201496579, 12878.549250776177, 12963.740725185633, 12634.0, 12640.74718505643, 12706.618801435972, 12833.42249598789, 13256.469741210629, 12548.874511254771, 12600.495980160691, 12720.6819829505, 12875.0, 12926.095173337777], "value": 9201.36199716729, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1442.8196475440566, 1492.1196494068497, 1626.9267882945267, 1741.1468380493561, 1799.7480352750617, 8142.185781421855, 8827.646894124244, 8841.646334146642, 8847.734567962963, 8849.955750221256, 7577.621118944045, 7847.0, 8219.50682959023, 8455.069942306342, 8459.83080338393, 2307.59617067013, 2311.6648086027517, 2311.768823117683, 2329.4642232286583, 2331.892351133215, 2280.6236970899863, 2310.1914329984456, 2326.150954901457, 2338.4855331827057, 2342.6837376954063, 2009.357005758158, 2068.2037415595028, 2235.396442960408, 2289.6222123349626, 2291.175176936302, 2235.284708893155, 2240.6526988316755, 2269.6482045283005, 2270.6707527408516, 2271.4207876991263, 2294.3346429535413, 2295.2425699519117, 2299.3906614747107, 2301.5396920615945, 2304.43541332373, 8474.576271186415, 8607.225349718492, 8642.65429382824, 8646.870296945552, 8663.090375510543, 5098.158803797369, 5187.896242075138, 5219.138842091051, 5258.710770907599, 5264.473552644743, 3173.079806856009, 3224.8548815303366, 3386.2380964283084, 3388.525606415104, 3391.6438773928876, 1069.893010698924, 1069.919756018294, 1083.6044843632096, 1093.907017903479, 1098.906592939601, 11676.416179191006, 11721.35532545701, 11727.7068073298, 11729.120315976335, 11794.646160615195, 4258.638015768633, 4402.889927751832, 4508.661850361236, 4599.793009314589, 4617.8845528861375, 10011.048950349705, 10054.798904021878, 10059.195264378832, 10068.597256109673, 10075.546600402853, 5073.543381095719, 5113.437521872591, 5118.411382690963, 5118.641695081383, 5130.0, 4608.562186592336, 4727.936214351744, 4743.881402964954, 4771.284307353924, 4783.784729687172, 3665.157013886768, 3750.6061863504483, 3766.133789228493, 3769.754965927206, 3813.904652383713, 1220.6155061155707, 1272.0840994483956, 1275.0609844308956, 1282.2562913510142, 1289.5873320537337, 722.5447967780265, 809.5911564659809, 940.576740466779, 950.296780382512, 950.8288508068614, 5211.713355765393, 5510.1459273812625, 5578.888422231533, 5584.91622625661, 5599.776008959596, 939.3847030195233, 947.7677968897526, 949.7768024514234, 977.6236149082512, 984.8276551603584, 3624.257027309395, 3798.5441746989986, 3805.1058001369656, 3807.961920380816, 3855.4602355670227, 10371.118454931264, 10787.460626968621, 10793.730156746144, 10795.244332896778, 10796.352218866894, 10600.204984626183, 10688.465576721133, 10694.411807350514, 10699.518521666543, 10701.304415213142, 7586.431017673807, 8014.038315402189, 8083.7170699025255, 8100.311473524816, 8100.918990810016, 5709.771609135588, 5756.165356023437, 5970.373110823301, 5975.0, 6088.634681919099, 9320.860187097063, 9399.436033837992, 9497.14525692691, 9561.235101191749, 9578.23374130054, 9671.274654401088, 9940.155086817702, 10033.09702126812, 10081.69754907354, 10224.437655928697, 7637.427192960439, 7711.807204819925, 7802.843943120993, 7804.024496937883, 7804.2585954334245, 8355.0, 8368.581570921308, 8384.706535271236, 8386.32909367237, 8388.622511987098, 7449.813754656177, 7467.43994200448, 7473.43949203801, 7595.202503737028, 7763.146053934176, 7276.090488688914, 7290.635468226461, 7354.852902942018, 7375.188729239672, 7413.406927445899, 6655.267920528835, 6657.567258128206, 6703.229128650268, 6712.496562757715, 6729.495287853332, 4732.597729192919, 4900.95099049005, 4953.331300274417, 4978.253262010728, 5035.446100928822, 4886.755662216946, 5002.949970500248, 5022.0, 5125.43620201785, 5141.28022076902], "value": 4512.010087784582, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [323.89959112675075, 325.92014956335703, 335.34440169468684, 335.5252317970072, 342.3204938197679, 5145.3568303962, 5239.358645741211, 5281.2342210379475, 5347.35831700196, 5360.981413531431, 5176.404713457953, 5296.867578310535, 5297.708626025567, 5300.973495132529, 5304.761285742141, 4192.7484350938885, 4198.0, 4201.159768046387, 4202.3696445533105, 4230.081243941686, 4004.9199016019807, 4144.461220041406, 4248.299030659953, 4249.893752656193, 4252.299080367847, 4127.298359278915, 4134.780239829258, 4137.979310103446, 4138.255114079465, 4138.813753381105, 4124.8556300529635, 4131.5042194936495, 4152.875413737577, 4155.7506549606815, 4163.646090082347, 3678.1724112074835, 3687.870924517629, 3695.482632431435, 3695.593484716679, 3702.87039953603, 5106.289502850722, 5166.535011848914, 5171.405288391846, 5258.2638430619745, 5266.657667251617, 4701.858944231644, 4708.670393072486, 4718.740469274188, 4722.244440889475, 4775.689580177277, 5498.2337797113805, 5540.722963851791, 5544.140658197945, 5551.444855514456, 5593.888122237532, 3888.202918401721, 3968.1865217630607, 3985.9800700996598, 3986.5614782373914, 3997.520297564282, 5728.742206600713, 5761.567882408836, 5773.797917072924, 5790.594658373915, 5818.825435236908, 4110.46563946691, 4124.587541245852, 4132.553606237792, 4132.586741325904, 4133.46264985556, 3941.5270167580074, 4129.566395528486, 4136.358864376027, 4151.647109995684, 4180.853670121531, 4723.149833030019, 4736.029114031615, 4742.762861856893, 4746.335513028179, 4747.359106520576, 5580.888382232332, 5613.410591887875, 5620.606557541015, 5637.605367624227, 5664.20701101846, 1292.8254685617321, 1325.1452812935602, 1394.7489451898552, 1407.268220525321, 1408.3169662713576, 881.1973156762662, 888.8266787976412, 909.3043821476575, 911.4323363814229, 916.2395211974045, 4706.576113301652, 4717.622590192776, 4719.834805781781, 4726.692764970266, 4730.361401210793, 4984.152694042022, 5000.349954505891, 5005.370032719792, 5024.49755024502, 5062.291279220912, 4601.309803529497, 4699.130660827758, 4718.357719676992, 4758.500357462417, 4795.544423279783, 2633.2626864477975, 2669.5595226787364, 2675.7190494998135, 2687.704352521221, 2710.7424794644476, 5103.014736379259, 5106.442535026778, 5108.463611320833, 5181.409295352324, 5217.191335343028, 4704.95295047052, 4952.034353301072, 5033.476566403532, 5068.4424713281505, 5068.695878247243, 5029.396472423333, 5098.847034588894, 5110.948890511122, 5114.820981265638, 5141.820036298712, 4903.53416425439, 4964.67729597575, 4989.451160372283, 4993.5755460784785, 4998.225275082368, 4917.28699338601, 4929.309896614405, 4945.332380128637, 5257.2902658140665, 5672.461116193955, 5889.64662120257, 5894.351621321565, 5903.2916050072545, 5903.439173278532, 5924.318703348998, 4038.6567141793275, 4066.34938409853, 4072.7963601819197, 4073.287174744467, 4075.551689314114, 5423.511883930465, 5462.781488740406, 5719.227904233042, 5760.913586296293, 5787.131930210502, 5461.699606521679, 5482.600787511768, 5592.273004509388, 5612.5509959202345, 5633.183188437735, 5584.916226256528, 5585.441455854382, 5601.159826026129, 5603.7758489659955, 5613.607047506799, 5371.785128594813, 5597.692126932895, 5612.214289999321, 5626.493615574618, 5630.071038278638, 5673.290838645169, 5677.489025987681, 5683.749575093473, 5683.8863222736145, 5690.886182276248, 5377.435369286325, 5454.781808727606, 5550.972245138749, 5578.609497335147, 5585.5531557476115], "value": 4114.44291111143, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [678.8336857469919, 737.3097646280366, 774.7598244544188, 787.3307688464805, 798.313897422132, 12467.37663116845, 12889.677758056054, 14759.335829887654, 16620.91689541552, 16651.500454986355, 12814.551490697828, 13393.397297121628, 13500.12249203801, 13590.59228223155, 13836.515721949734, 793.2900054451262, 819.49600995388, 831.8627426474654, 832.8334333133398, 833.5248908122372, 673.6261374936909, 687.2234375156091, 801.8356236971407, 819.6270696832927, 825.455199568285, 860.2000139869918, 860.3332417376552, 860.4794099569764, 860.8579584368572, 864.5806783709895, 857.6655104509247, 859.1751918158575, 860.5568132411844, 860.6901515454431, 860.7805009722543, 629.0061702510023, 629.408356145222, 630.5491573524952, 631.3244828034005, 631.564220687724, 14157.929210353985, 14166.92916535421, 14171.433142674281, 14175.645608859757, 14187.716245675132, 14561.271936403244, 15055.698886022219, 15146.924265378713, 15290.847091529053, 15472.381104755796, 11441.885581144164, 11553.711157221052, 11669.533218671242, 12371.381430928417, 12728.912319644898, 3848.2303539291975, 3921.431392448079, 3938.4321014106413, 3950.3679411294056, 3981.1838573092737, 78036.60981695112, 79598.60200699075, 80251.19748802496, 80897.59551202206, 82227.0, 11665.358405287621, 12096.153269271066, 12219.938900305619, 12385.690357740948, 12509.0, 23545.646815297783, 23669.644955325683, 23901.326907116683, 24041.158559450687, 24080.87959560191, 7822.1004584472375, 8042.718504852302, 8111.878321825059, 8150.2664760171865, 8177.95911020453, 4305.117450922553, 4420.31485119807, 4520.52534483881, 4611.584957353854, 4653.139169253699, 3338.132085657698, 3379.5099710541836, 3390.5253264542985, 3408.471686888536, 3418.897433076962, 597.9760809567568, 600.9579329446897, 604.1089393145076, 612.1766224428137, 626.7774939896362, 564.8305508347479, 600.8978473659488, 652.7030201258416, 671.9832004199934, 693.3759616345329, 8484.0, 9125.269978401711, 9338.65648324941, 9664.71005869825, 9749.415035097774, 589.8849724303719, 622.3589702606323, 661.5633681770008, 710.9217986021533, 719.1083057009271, 4654.743989080565, 4828.179209534387, 4908.656394052454, 5216.556592689588, 5257.0, 88757.55621221852, 119941.40029299798, 121249.0, 123832.38083809703, 124527.0, 76239.23760762432, 78815.60592197003, 89327.55336223278, 89526.0, 89938.0, 68532.0, 78791.21208787954, 79632.0, 80367.0, 83373.0, 8960.372773905765, 9549.522523873917, 9611.615535378785, 9656.0, 9825.263105267277, 50998.0, 51065.74467127641, 51866.74066629643, 53043.93912121813, 53931.0, 68830.65584672044, 72046.27953720395, 72340.0, 74248.25751742629, 76829.61585192039, 12335.3832308386, 12514.499420023098, 12550.560730374393, 12621.93689031549, 13334.666633334244, 12984.480620775441, 13339.333033348488, 13343.599692009255, 13845.515406960709, 13890.916362545699, 13655.0, 13765.793513097111, 14180.858191418367, 14472.493462728755, 14486.348114334669, 12588.685282867635, 13002.609921702364, 14164.150150990974, 14423.567292981228, 14795.334209960361, 12857.871421285667, 12999.610011699664, 13589.184648921097, 13922.303884805922, 14058.086224395382, 10727.570897164025, 11006.944965275123, 11077.667669969915, 11177.441127943408, 11325.490352934303, 9723.416595004323, 10430.217733669853, 11381.317120972768, 11464.541418343173, 11698.239614425376], "value": 7428.034517253265, "unit": "score"}], "name": "dromaeo_css", "value": 7133.2061304114095, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 109.0, 112.0, 117.0, 110.0, 110.0, 110.0, 110.0, 109.0, 109.0], "value": 109.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 122.0, 123.0, 159.0, 123.0, 124.0, 129.0, 121.0, 158.0, 123.0], "value": 133.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 161.0, 160.0, 160.0, 160.0, 161.0, 161.0, 161.0, 160.0, 161.0], "value": 160.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 75.0, 108.0, 77.0, 77.0, 76.0, 77.0, 99.0, 76.0], "value": 81.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 125.0, 82.0, 82.0, 82.0, 106.0, 84.0, 81.0, 115.0], "value": 92.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 118.0, 117.0, 118.0, 119.0, 118.0, 118.0], "value": 117.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 146.0, 145.0, 145.0, 145.0, 146.0, 146.0, 147.0, 145.0], "value": 145.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 84.0, 85.0, 86.0, 86.0, 85.0, 86.0, 85.0, 84.0], "value": 85.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 53.0, 54.0, 52.0, 55.0, 55.0, 56.0, 54.0, 55.0, 55.0], "value": 54.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 59.0, 60.0, 60.0, 59.0, 60.0, 59.0, 63.0, 61.0, 60.0], "value": 60.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 81.0, 79.0, 79.0, 83.0, 86.0, 79.0, 90.0, 80.0, 79.0], "value": 81.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 135.0, 135.0, 145.0, 132.0, 132.0, 131.0, 130.0, 177.0, 142.0], "value": 139.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 180.0, 167.0, 167.0, 166.0, 167.0, 165.0, 167.0, 165.0, 167.0], "value": 168.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 68.0, 67.0, 65.0, 67.0, 67.0, 66.0, 65.0, 67.0, 66.0], "value": 66.4, "unit": "score"}], "name": "kraken", "value": 1495.4, "alertThreshold": 2.0}]} 06:43:22 INFO - Return code: 0 06:43:22 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:43:22 INFO - # TBPL SUCCESS # 06:43:22 INFO - Running post-action listener: _resource_record_post_action 06:43:22 INFO - [mozharness: 2016-10-19 13:43:22.480010Z] Finished run-tests step (success) 06:43:22 INFO - Running post-run listener: _resource_record_post_run 06:43:22 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 4096; Write bytes: 391749632; Read time: 20; Write time: 376572 06:43:22 INFO - TinderboxPrint: CPU usage
13.1% 06:43:22 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 20 06:43:22 INFO - TinderboxPrint: I/O write bytes / time
391,749,632 / 376,572 06:43:22 INFO - TinderboxPrint: CPU idle
8,295.8 (86.9%) 06:43:22 INFO - TinderboxPrint: CPU user
1,202.8 (12.6%) 06:43:22 INFO - TinderboxPrint: Swap in / out
0 / 0 06:43:22 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 103677952; Read time: 0; Write time: 145264 06:43:22 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 0; Write bytes: 288071680; Read time: 0; Write time: 231308 06:43:23 INFO - Running post-run listener: _upload_blobber_files 06:43:23 INFO - Blob upload gear active. 06:43:23 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:43: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:43: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:43: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:43:23 INFO - (blobuploader) - INFO - Open directory for files ... 06:43:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:43:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:43:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:43:26 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:43:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:43:26 INFO - (blobuploader) - INFO - Done attempting. 06:43:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:43:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:43:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:43:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:43:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:43:28 INFO - (blobuploader) - INFO - Done attempting. 06:43:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:43:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:43:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:43:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:43:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:43:29 INFO - (blobuploader) - INFO - Done attempting. 06:43:29 INFO - (blobuploader) - INFO - Iteration through files over. 06:43:29 INFO - Return code: 0 06:43:29 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:43:29 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:43:29 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e5fe7b588c159f841cab9cdbc9b62308f2a988806d0279cafc77e62de7661be443de031fe50602ac27c834ced7a270f1bb6621ce7f8b28777de2bc7a89210558", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/538a042c6d845631080f73f5856776b9eb06d618a4329edbee5509866a8fce484d717067cdfa18a2383ce008864103a310f3dd94e8eadbbd3544c1dd42cbddc7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/636957a8afd99399df65238e28fc3cdb5207978aaeca9d1ac62236875b010bd6b4bea6a404af749e2998209b09305dcf6548e9c24d970cd22bdcc9d46f05c6cb"} 06:43:29 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:43:29 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:43:29 INFO - Contents: 06:43:29 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e5fe7b588c159f841cab9cdbc9b62308f2a988806d0279cafc77e62de7661be443de031fe50602ac27c834ced7a270f1bb6621ce7f8b28777de2bc7a89210558", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/538a042c6d845631080f73f5856776b9eb06d618a4329edbee5509866a8fce484d717067cdfa18a2383ce008864103a310f3dd94e8eadbbd3544c1dd42cbddc7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/636957a8afd99399df65238e28fc3cdb5207978aaeca9d1ac62236875b010bd6b4bea6a404af749e2998209b09305dcf6548e9c24d970cd22bdcc9d46f05c6cb"} 06:43:29 INFO - Running post-run listener: copy_logs_to_upload_dir 06:43:29 INFO - Copying logs to upload dir... 06:43:29 INFO - mkdir: /builds/slave/test/build/upload/logs 06:43:29 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1243.770245 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-10-19 06:43:28.427231) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-19 06:43:28.435067) ========= 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=fa44defc139c4ba8574fe040000001db-1476881895.368588-165433251 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/e5fe7b588c159f841cab9cdbc9b62308f2a988806d0279cafc77e62de7661be443de031fe50602ac27c834ced7a270f1bb6621ce7f8b28777de2bc7a89210558", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/538a042c6d845631080f73f5856776b9eb06d618a4329edbee5509866a8fce484d717067cdfa18a2383ce008864103a310f3dd94e8eadbbd3544c1dd42cbddc7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/636957a8afd99399df65238e28fc3cdb5207978aaeca9d1ac62236875b010bd6b4bea6a404af749e2998209b09305dcf6548e9c24d970cd22bdcc9d46f05c6cb"} build_url:https://queue.taskcluster.net/v1/task/cNTRzk_8ST6jwfySUbuL_Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011468 build_url: 'https://queue.taskcluster.net/v1/task/cNTRzk_8ST6jwfySUbuL_Q/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/e5fe7b588c159f841cab9cdbc9b62308f2a988806d0279cafc77e62de7661be443de031fe50602ac27c834ced7a270f1bb6621ce7f8b28777de2bc7a89210558", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/538a042c6d845631080f73f5856776b9eb06d618a4329edbee5509866a8fce484d717067cdfa18a2383ce008864103a310f3dd94e8eadbbd3544c1dd42cbddc7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/636957a8afd99399df65238e28fc3cdb5207978aaeca9d1ac62236875b010bd6b4bea6a404af749e2998209b09305dcf6548e9c24d970cd22bdcc9d46f05c6cb"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-19 06:43:28.463040) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-19 06:43:28.463390) ========= 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=fa44defc139c4ba8574fe040000001db-1476881895.368588-165433251 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004584 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-19 06:43:28.543322) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-19 06:43:28.543624) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-19 06:43:28.546436) ========= ========= Total master_lag: 0.17 =========